Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.0/2/
1 tests failed.
FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=119758, name=collection0,
state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=119758, name=collection0, state=RUNNABLE,
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
at
__randomizedtesting.SeedInfo.seed([4886FA7E55D3EFD4:C0D2C5A4FB2F822C]:0)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:57348: collection already exists:
awholynewstresscollection_collection0_3
at __randomizedtesting.SeedInfo.seed([4886FA7E55D3EFD4]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:973)
Build Log:
[...truncated 12012 lines...]
[junit4] JVM J2: stdout was not empty, see:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/temp/junit4-J2-20160331_172637_334.sysout
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] Dumping heap to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/heapdumps/java_pid19814.hprof
...
[junit4] Heap dump file created [607036398 bytes in 67.289 secs]
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J2: stderr was not empty, see:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/temp/junit4-J2-20160331_172637_334.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] WARN: Unhandled exception in event serialization. ->
java.lang.OutOfMemoryError: GC overhead limit exceeded
[junit4] <<< JVM J2: EOF ----
[...truncated 681 lines...]
[junit4] Suite:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/init-core-data-001
[junit4] 2> 6847967 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 6847967 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 6848125 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 6848132 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 6848133 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 6848182 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_45454_hdfs____dmoiu4/webapp
[junit4] 2> 6848342 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 6848619 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:45454
[junit4] 2> 6849145 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 6849146 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 6849157 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_53122_datanode____8p2jp6/webapp
[junit4] 2> 6849278 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 6849588 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:53122
[junit4] 2> 6849988 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 6849989 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 6850013 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_55315_datanode____zh7l26/webapp
[junit4] 2> 6850230 INFO (IPC Server handler 4 on 33231) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-ffc6d9af-1a13-4a8b-84a6-62f1cde52869 node DatanodeRegistration(127.0.0.1,
datanodeUuid=8ba66edf-970b-46a7-b5e1-28e9710f9466, infoPort=53122,
ipcPort=53166, storageInfo=lv=-56;cid=testClusterID;nsid=2131769303;c=0),
blocks: 0, hasStaleStorages: true, processing time: 0 msecs
[junit4] 2> 6850231 INFO (IPC Server handler 4 on 33231) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-e8165f1a-d5a3-4309-bb71-36278c475201 node DatanodeRegistration(127.0.0.1,
datanodeUuid=8ba66edf-970b-46a7-b5e1-28e9710f9466, infoPort=53122,
ipcPort=53166, storageInfo=lv=-56;cid=testClusterID;nsid=2131769303;c=0),
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
[junit4] 2> 6850292 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 6850564 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[4886FA7E55D3EFD4]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:55315
[junit4] 2> 6850726 INFO (IPC Server handler 7 on 33231) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-6441d10b-f6b5-4c28-8904-12199d078f28 node DatanodeRegistration(127.0.0.1,
datanodeUuid=f676ec02-022e-4aa2-8f73-2b23fe75484d, infoPort=55315,
ipcPort=57966, storageInfo=lv=-56;cid=testClusterID;nsid=2131769303;c=0),
blocks: 0, hasStaleStorages: true, processing time: 0 msecs
[junit4] 2> 6850726 INFO (IPC Server handler 7 on 33231) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-91ff1b5e-4c8b-44c1-8194-dfa83f541738 node DatanodeRegistration(127.0.0.1,
datanodeUuid=f676ec02-022e-4aa2-8f73-2b23fe75484d, infoPort=55315,
ipcPort=57966, storageInfo=lv=-56;cid=testClusterID;nsid=2131769303;c=0),
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
[junit4] 2> 6851152 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 6851152 INFO (Thread-100372) [ ] o.a.s.c.ZkTestServer
client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 6851152 INFO (Thread-100372) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 6851253 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.ZkTestServer start zk server on port:38609
[junit4] 2> 6851254 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 6851274 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 6851282 INFO (zkCallback-4380-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5d16e60f
name:ZooKeeperConnection Watcher:127.0.0.1:38609 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6851282 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 6851283 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 6851283 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 6851298 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 6851306 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 6851320 INFO (zkCallback-4381-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1cc5a50a
name:ZooKeeperConnection Watcher:127.0.0.1:38609/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6851320 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 6851320 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 6851320 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 6851321 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 6851321 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 6851322 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 6851322 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 6851323 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 6851331 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 6851331 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 6851332 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 6851332 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 6851333 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 6851333 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 6851333 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 6851334 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 6851334 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 6851342 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 6851343 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 6851343 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 6851344 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 6851344 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 6851344 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 6851345 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 6851345 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 6851345 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 6851346 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 6851346 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 6851441 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/cores/collection1
[junit4] 2> 6851442 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 6851443 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5d84396d{/,null,AVAILABLE}
[junit4] 2> 6851444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@5e7e68ca{HTTP/1.1,[http/1.1]}{127.0.0.1:53622}
[junit4] 2> 6851444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.e.j.s.Server Started @6857136ms
[junit4] 2> 6851444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:33231/hdfs__localhost_33231__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.0_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001_tempDir-002_control_data,
hostContext=/, hostPort=53622,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/cores}
[junit4] 2> 6851444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 6851444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001'
[junit4] 2> 6851444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 6851444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 6851444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 6851446 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 6851453 INFO (zkCallback-4382-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@50efe35d
name:ZooKeeperConnection Watcher:127.0.0.1:38609/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6851453 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 6851454 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 6851454 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 6851454 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/solr.xml
[junit4] 2> 6851458 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/cores
[junit4] 2> 6851458 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.CoreContainer New CoreContainer 311564607
[junit4] 2> 6851458 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001]
[junit4] 2> 6851458 WARN
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/lib
[junit4] 2> 6851458 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 6851459 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 6851459 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 6851459 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 6851459 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38609/solr
[junit4] 2> 6851459 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 6851459 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 6851461 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 6851462 INFO (zkCallback-4385-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@36053816
name:ZooKeeperConnection Watcher:127.0.0.1:38609 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6851462 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 6851463 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 6851465 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 6851465 INFO
(zkCallback-4386-thread-1-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5277de3c
name:ZooKeeperConnection Watcher:127.0.0.1:38609/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6851465 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 6851466 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 6851467 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 6851468 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 6851469 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 6851471 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 6851472 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 6851473 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 6851473 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 6851474 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 6851474 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 6851475 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 6851475 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 6851476 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 6851476 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 6851477 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.LeaderElector Joined leadership election with
path: /overseer_elect/election/95646649825361924-127.0.0.1:53622_-n_0000000000
[junit4] 2> 6851477 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:53622_
[junit4] 2> 6851477 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 6851477 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.Overseer Overseer
(id=95646649825361924-127.0.0.1:53622_-n_0000000000) starting
[junit4] 2> 6851478 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 6851482 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 6851483 INFO
(OverseerCollectionConfigSetProcessor-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.OverseerTaskProcessor Process current queue
of overseer operations
[junit4] 2> 6851487 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53622_
[junit4] 2> 6851487 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 6851487 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:53622_
[junit4] 2> 6851496 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 6851503 INFO
(zkCallback-4386-thread-1-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 6851513 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 6851513 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 6851513 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/cores
[junit4] 2> 6851514 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 6851514 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.CorePropertiesLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/cores/collection1
[junit4] 2> 6851514 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 6851514 INFO
(zkCallback-4386-thread-1-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (1)
[junit4] 2> 6851531 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1
[junit4] 2> 6851532 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:53622_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 6851538 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 6851538 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 6851566 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.ZkController
look for our core node name
[junit4] 2> 6851582 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:53622";,
[junit4] 2> "node_name":"127.0.0.1:53622_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 6851607 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:53622";,
[junit4] 2> "node_name":"127.0.0.1:53622_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 6851608 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
control_collection
[junit4] 2> 6851608 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 6851610 INFO
(zkCallback-4386-thread-2-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 6852570 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.ZkController
waiting to find shard id in clusterstate for collection1
[junit4] 2> 6852570 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.ZkController
Check for collection zkNode:control_collection
[junit4] 2> 6852571 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 6852571 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 6852571 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 6852571 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/cores/collection1'
[junit4] 2> 6852571 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 6852571 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 6852572 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.Config loaded
config solrconfig.xml with version 0
[junit4] 2> 6852590 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.SolrConfig
current version of requestparams : -1
[junit4] 2> 6852599 WARN
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 6852600 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.0.0
[junit4] 2> 6852657 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 6852686 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 6853130 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 6853151 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.s.IndexSchema
default search field in schema is text
[junit4] 2> 6853151 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.s.IndexSchema
unique key field: id
[junit4] 2> 6853157 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 6853159 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 6853160 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 6853160 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 6853161 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/configs/conf1',
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1
[junit4] 2> 6853161 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 6853161 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory
[junit4] 2> 6853161 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:33231/solr_hdfs_home
[junit4] 2> 6853161 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 6853161 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/control-001/cores/collection1],
dataDir=[hdfs://localhost:33231/solr_hdfs_home/control_collection/core_node1/data/]
[junit4] 2> 6853161 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7d3d2352
[junit4] 2> 6853162 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:33231/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 6853222 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
hdfs://localhost:33231/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 6853226 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore New index directory detected: old=null
new=hdfs://localhost:33231/solr_hdfs_home/control_collection/core_node1/data/index/
[junit4] 2> 6856395 WARN
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [collection1] Solr index directory
'hdfs:/localhost:33231/solr_hdfs_home/control_collection/core_node1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 6856396 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:33231/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 6856429 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
hdfs://localhost:33231/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 6856429 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=10, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 6856504 INFO (IPC Server handler 2 on 33231) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:33766 is
added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION,
primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-ffc6d9af-1a13-4a8b-84a6-62f1cde52869:NORMAL:127.0.0.1:33766|RBW],
ReplicaUnderConstruction[[DISK]DS-6441d10b-f6b5-4c28-8904-12199d078f28:NORMAL:127.0.0.1:46167|RBW]]}
size 0
[junit4] 2> 6856504 INFO (IPC Server handler 0 on 33231) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:46167 is
added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION,
primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-ffc6d9af-1a13-4a8b-84a6-62f1cde52869:NORMAL:127.0.0.1:33766|RBW],
ReplicaUnderConstruction[[DISK]DS-6441d10b-f6b5-4c28-8904-12199d078f28:NORMAL:127.0.0.1:46167|RBW]]}
size 0
[junit4] 2> 6856508 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(HdfsDirectory@hdfs://localhost:33231/solr_hdfs_home/control_collection/core_node1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@77d09a1a;
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
[junit4] 2> 6856508 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 6856518 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
Looking for old index directories to cleanup for core collection1 in
hdfs://localhost:33231/solr_hdfs_home/control_collection/core_node1/data/
[junit4] 2> 6856520 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 6856520 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 6856520 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 6856520 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 6856520 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 6856521 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 6856521 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 6856521 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 6856521 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating
implicit default
[junit4] 2> 6856521 WARN
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 6856534 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 6856535 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 6856536 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 6856536 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 6856579 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
[junit4] 2> 6856579 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 6856585 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 6856585 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
tlogDfsReplication=2
[junit4] 2> 6856611 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 6856611 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 6856612 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=37, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=14.845703125,
floorSegmentMB=1.810546875, forceMergeDeletesPctAllowed=12.869746560226616,
segmentsPerTier=28.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 6856635 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(HdfsDirectory@hdfs://localhost:33231/solr_hdfs_home/control_collection/core_node1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@77d09a1a;
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
[junit4] 2> 6856635 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 6856635 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6a2b924c[collection1] main]
[junit4] 2> 6856635 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 6856636 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 6856636 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the
RestManager with znodeBase: /configs/conf1
[junit4] 2> 6856644 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 6856644 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 6856645 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 6856650 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage No data found for znode
/configs/conf1/_rest_managed.json
[junit4] 2> 6856651 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 6856651 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 6856651 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 6856651 INFO
(searcherExecutor-9797-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
[collection1] Registered new searcher Searcher@6a2b924c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 6856652 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 6856652 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 256 version
buckets from index
[junit4] 2> 6856652 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket
highest value from index
[junit4] 2> 6856652 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1530346402971910144
[junit4] 2> 6856652 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Took 0.0ms to seed version buckets with highest version
1530346402971910144
[junit4] 2> 6856652 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 6856656 INFO
(coreLoadExecutor-9795-thread-1-processing-n:127.0.0.1:53622_)
[n:127.0.0.1:53622_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 6856658 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
Register replica - core:collection1 address:http://127.0.0.1:53622
collection:control_collection shard:shard1
[junit4] 2> 6856667 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 6856671 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector
Joined leadership election with path:
/collections/control_collection/leader_elect/shard1/election/95646649825361924-core_node1-n_0000000000
[junit4] 2> 6856671 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard1
and weAreReplacement=false and leaderVoteWait=180000
[junit4] 2> 6856673 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 6856673 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 6856674 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:53622/collection1/
[junit4] 2> 6856674 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 6856674 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:53622/collection1/ has no replicas
[junit4] 2> 6856674 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state version: 1
[junit4] 2> 6856676 INFO
(zkCallback-4386-thread-2-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 6856678 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 6856680 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/control_collection/leaders/shard1/leader after winning as
/collections/control_collection/leader_elect/shard1/election/95646649825361924-core_node1-n_0000000000
[junit4] 2> 6856680 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:53622/collection1/ shard1
[junit4] 2> 6856681 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:53622";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 6856906 INFO
(zkCallback-4386-thread-2-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 6856955 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are http://127.0.0.1:53622/collection1/ and leader is
http://127.0.0.1:53622/collection1/
[junit4] 2> 6856955 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:53622
[junit4] 2> 6856955 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 6856955 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 6856955 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 6856956 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:53622";,
[junit4] 2> "node_name":"127.0.0.1:53622_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 3
[junit4] 2> 6856956 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:53622";,
[junit4] 2> "node_name":"127.0.0.1:53622_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 6856957 INFO
(coreZkRegister-9790-thread-1-processing-n:127.0.0.1:53622_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:53622_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (1)
[junit4] 2> 6857058 INFO
(zkCallback-4386-thread-2-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 6857112 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 6857118 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 6857134 INFO (zkCallback-4388-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2174f952
name:ZooKeeperConnection Watcher:127.0.0.1:38609/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6857134 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 6857135 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 6857135 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 6857135 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 6857136 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 6857224 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001/cores/collection1
[junit4] 2> 6857225 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001
[junit4] 2> 6857227 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 6857232 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@299de02a{/,null,AVAILABLE}
[junit4] 2> 6857394 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@225e0d39{HTTP/1.1,[http/1.1]}{127.0.0.1:35537}
[junit4] 2> 6857394 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.e.j.s.Server Started @6863087ms
[junit4] 2> 6857394 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:33231/hdfs__localhost_33231__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.0_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001_tempDir-002_jetty1,
solrconfig=solrconfig.xml, hostContext=/, hostPort=35537,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001/cores}
[junit4] 2> 6857395 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 6857395 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001'
[junit4] 2> 6857395 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 6857395 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 6857396 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 6857398 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 6857400 INFO (zkCallback-4389-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@32f0f6e4
name:ZooKeeperConnection Watcher:127.0.0.1:38609/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6857400 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 6857401 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 6857402 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 6857402 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001/solr.xml
[junit4] 2> 6857406 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001/cores
[junit4] 2> 6857406 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.CoreContainer New CoreContainer 962180693
[junit4] 2> 6857407 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001]
[junit4] 2> 6857407 WARN
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001/lib
[junit4] 2> 6857413 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 6857414 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 6857414 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 6857414 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 6857414 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38609/solr
[junit4] 2> 6857414 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 6857414 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 6857428 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 6857454 INFO (zkCallback-4392-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@110ee07a
name:ZooKeeperConnection Watcher:127.0.0.1:38609 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6857456 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 6857456 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 6857457 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x153ce1f0acc0007, 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> 6857482 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 6857498 INFO
(zkCallback-4393-thread-1-processing-n:127.0.0.1:35537_) [n:127.0.0.1:35537_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1160efef
name:ZooKeeperConnection Watcher:127.0.0.1:38609/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 6857502 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 6857505 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 6857514 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 6857515 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 6857516 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.LeaderElector Joined leadership election with
path: /overseer_elect/election/95646649825361928-127.0.0.1:35537_-n_0000000001
[junit4] 2> 6857516 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/95646649825361924-127.0.0.1:53622_-n_0000000000 to
know if I could be the leader
[junit4] 2> 6857516 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.ZkController Publish node=127.0.0.1:35537_ as
DOWN
[junit4] 2> 6857517 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:35537_"} current state version: 4
[junit4] 2> 6857517 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.o.NodeMutator DownNode state invoked for node:
127.0.0.1:35537_
[junit4] 2> 6857623 INFO (zkCallback-4388-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 6857623 INFO
(zkCallback-4386-thread-2-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 6857626 INFO
(zkCallback-4393-thread-1-processing-n:127.0.0.1:35537_) [n:127.0.0.1:35537_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [1])
[junit4] 2> 6858518 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35537_
[junit4] 2> 6858519 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:35537_
[junit4] 2> 6858519 INFO
(zkCallback-4386-thread-2-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 6858519 INFO (zkCallback-4388-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 6858520 INFO (zkCallback-4388-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 6858520 INFO
(zkCallback-4386-thread-2-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 6858520 INFO
(zkCallback-4393-thread-1-processing-n:127.0.0.1:35537_) [n:127.0.0.1:35537_
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 6858520 INFO
(zkCallback-4393-thread-1-processing-n:127.0.0.1:35537_) [n:127.0.0.1:35537_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 6858553 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 6858553 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 6858566 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001/cores
[junit4] 2> 6858567 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
collection=collection1, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 6858567 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.CorePropertiesLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_4886FA7E55D3EFD4-001/shard-1-001/cores/collection1
[junit4] 2> 6858567 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 6858575 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1
[junit4] 2> 6858575 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[4886FA7E55D3EFD4])
[n:127.0.0.1:35537_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 6858578 INFO
(coreLoadExecutor-9807-thread-1-processing-n:127.0.0.1:35537_)
[n:127.0.0.1:35537_ c:collection1 x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 6858578 INFO
(coreLoadExecutor-9807-thread-1-processing-n:127.0.0.1:35537_)
[n:127.0.0.1:35537_ c:collection1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 6858579 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:35537";,
[junit4] 2> "node_name":"127.0.0.1:35537_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"} current state version: 5
[junit4] 2> 6858579 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:35537";,
[junit4] 2> "node_name":"127.0.0.1:35537_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"collection1",
[junit4] 2> "operation":"state"}
[junit4] 2> 6858580 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
collection1
[junit4] 2> 6858580 INFO
(OverseerStateUpdate-95646649825361924-127.0.0.1:53622_-n_0000000000)
[n:127.0.0.1:53622_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 6858590 INFO
(coreLoadExecutor-9807-thread-1-processing-n:127.0.0.1:35537_)
[n:127.0.0.1:35537_ c:collection1 x:collection1] o.a.s.c.ZkController look
for our core node name
[junit4] 2> 6858683 INFO
(zkCallback-4386-thread-2-processing-n:127.0.0.1:53622_) [n:127.0.0.1:53622_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [2])
[junit4] 2> 6858686 INFO (zkCallback-4388-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [2])
[junit4] 2> 6858686 INFO
(zkCallback-4393-thread-1-processing-n:127.0.0.1:35537_) [n:127.0.0.1:35537_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred
- updating... (live nodes size: [2])
[junit4] 2> 6859591 INFO
(coreLoadExecutor-9807-thread-1-processing-n:127.0.0.1:35537_)
[n:127.0.0.1:35537_ c:collection1 x:collection1] o.a.s.c.ZkController waiting
to find shard id in clusterstate for collection1
[junit4] 2> 6859591 INFO
(coreLoadExecutor-9807-thread-1-processing-n:127.0.0.1:35537_)
[n:127.0.0.1:35537_ c:collection1 x:collection1] o.a.s.c.ZkController Check
for collection zkNode:collection1
[junit4] 2> 6859592 INFO
(coreLoadExecutor-9807-thread-1-processing-n:127.0.0.1:35537_)
[n:127.0.0.1:35537_ c:collection1 x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 6859592 INFO (coreLoadExecutor
[...truncated too long message...]
-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-collective-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-event-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-exception-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-journal-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-normalization-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-operational-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-referral-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-schema-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-subtree-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-interceptors-trigger-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-jdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-jdbm1-2.0.0-M2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-kerberos-codec-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-ldif-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-mavibot-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-protocol-kerberos-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-protocol-ldap-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-protocol-shared-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/apacheds-xdbm-partition-2.0.0-M15.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/api-all-1.0.0-M20.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/bcprov-jdk15-1.45.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/cglib-nodep-2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/commons-collections-3.2.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/commons-math3-3.4.1.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/easymock-3.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/ehcache-core-2.4.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/hadoop-common-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/hadoop-hdfs-2.6.0-tests.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/hadoop-minikdc-2.6.0.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/jackson-annotations-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/jackson-databind-2.5.4.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/jersey-core-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/jersey-server-1.9.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/jetty-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/jetty-util-6.1.26.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/mina-core-2.0.0-M5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/mockito-core-1.9.5.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/objenesis-1.2.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/presto-parser-0.122.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/test-lib/slice-0.10.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/build/analysis/icu/lucene-analyzers-icu-6.0.0-SNAPSHOT.jar:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/contrib/solr-analysis-extras/classes/java:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/build/queryparser/classes/test:/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/contrib/analysis-extras/lib/icu4j-56.1.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-launcher.jar:/x1/jenkins/.ant/lib/ivy-2.3.0.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-antlr.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-regexp.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-resolver.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-net.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jmf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-oro.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-xalan2.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-commons-logging.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jsch.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit4.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-javamail.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jai.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-jdepend.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-junit.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bsf.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-swing.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-netrexx.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-bcel.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-testutil.jar:/home/jenkins/jenkins-slave/tools/hudson.tasks.Ant_AntInstallation/ant-1.8.2/lib/ant-apache-log4j.jar:/x1/jenkins/jenkins-slave/tools/hudson.model.JDK/latest1.8/lib/tools.jar:/x1/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.3.2.jar
com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/temp/junit4-J2-20160331_172637_334.events
@/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/temp/junit4-J2-20160331_172637_334.suites
-stdin
[junit4] ERROR: JVM J2 ended with an exception: Quit event not received from
the forked process? This may indicate JVM crash or runner bugs.
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1501)
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:121)
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:955)
[junit4] at
com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:952)
[junit4] at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] at java.lang.Thread.run(Thread.java:745)
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:747:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:684:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/common-build.xml:527:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/common-build.xml:1457:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/common-build.xml:1014:
At least one slave process threw an exception, first: Quit event not received
from the forked process? This may indicate JVM crash or runner bugs.
Total time: 312 minutes 29 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of 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]
