Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1638/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseParallelGC
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.RollingRestartTest
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.cloud.RollingRestartTest:
1) Thread[id=978, name=qtp1660790768-978, state=TIMED_WAITING,
group=TGRP-RollingRestartTest] at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.RollingRestartTest:
1) Thread[id=978, name=qtp1660790768-978, state=TIMED_WAITING,
group=TGRP-RollingRestartTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([4DD3A648D35DC9B7]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.RollingRestartTest
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=978, name=qtp1660790768-978, state=TIMED_WAITING,
group=TGRP-RollingRestartTest] at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=978, name=qtp1660790768-978, state=TIMED_WAITING,
group=TGRP-RollingRestartTest]
at sun.misc.Unsafe.park(Native Method)
at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([4DD3A648D35DC9B7]:0)
Build Log:
[...truncated 11725 lines...]
[junit4] Suite: org.apache.solr.cloud.RollingRestartTest
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/init-core-data-001
[junit4] 2> 158342 WARN
(SUITE-RollingRestartTest-seed#[4DD3A648D35DC9B7]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=10 numCloses=10
[junit4] 2> 158346 INFO
(SUITE-RollingRestartTest-seed#[4DD3A648D35DC9B7]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 158348 INFO
(SUITE-RollingRestartTest-seed#[4DD3A648D35DC9B7]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 158350 INFO
(SUITE-RollingRestartTest-seed#[4DD3A648D35DC9B7]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 158350 INFO
(SUITE-RollingRestartTest-seed#[4DD3A648D35DC9B7]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /igs/uc
[junit4] 2> 158356 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 158357 INFO (Thread-122) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 158357 INFO (Thread-122) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 158361 ERROR (Thread-122) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 158456 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.ZkTestServer start zk server on port:58082
[junit4] 2> 158462 INFO (zkConnectionManagerCallback-134-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 158468 INFO (zkConnectionManagerCallback-136-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 158481 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 158484 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 158486 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 158488 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 158490 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 158492 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 158494 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 158495 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 158500 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 158505 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 158510 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 158517 INFO (zkConnectionManagerCallback-139-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 158525 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly
asked otherwise
[junit4] 2> 158710 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.Server
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T11:27:37-10:00, git hash:
82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 158710 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 158710 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
No SessionScavenger set, using defaults
[junit4] 2> 158710 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
Scavenging every 600000ms
[junit4] 2> 158710 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4de42639{/igs/uc,null,AVAILABLE}
[junit4] 2> 158714 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@39d65562{SSL,[ssl,
http/1.1]}{127.0.0.1:42492}
[junit4] 2> 158714 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.Server
Started @161050ms
[junit4] 2> 158714 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/tempDir-001/control/data,
replicaType=NRT, hostContext=/igs/uc, hostPort=42492,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/control-001/cores}
[junit4] 2> 158714 ERROR
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 158714 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 158714 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 158714 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 158714 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-21T16:20:00.797Z
[junit4] 2> 158724 INFO (zkConnectionManagerCallback-141-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 158728 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 158728 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/control-001/solr.xml
[junit4] 2> 158731 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 158731 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 158732 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 158733 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58082/solr
[junit4] 2> 158739 INFO (zkConnectionManagerCallback-145-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 158753 INFO
(zkConnectionManagerCallback-147-thread-1-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.c.ConnectionManager zkClient has
connected
[junit4] 2> 158904 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 158905 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.OverseerElectionContext I am going to
be the leader 127.0.0.1:42492_igs%2Fuc
[junit4] 2> 158906 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.Overseer Overseer
(id=99388725686697989-127.0.0.1:42492_igs%2Fuc-n_0000000000) starting
[junit4] 2> 158934 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42492_igs%2Fuc
[junit4] 2> 158937 INFO
(OverseerStateUpdate-99388725686697989-127.0.0.1:42492_igs%2Fuc-n_0000000000)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (1)
[junit4] 2> 158996 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 159024 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 159024 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 159025 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/control-001/cores
[junit4] 2> 159043 INFO (zkConnectionManagerCallback-153-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 159045 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 159046 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58082/solr ready
[junit4] 2> 159118 INFO (qtp1380590914-793) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:42492_igs%252Fuc&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 159121 INFO
(OverseerThreadFactory-406-thread-1-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.a.c.CreateCollectionCmd Create
collection control_collection
[junit4] 2> 159266 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 159273 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 159388 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/control_collection/state.json] for collection
[control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 160300 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 160308 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
[junit4] 2> 160360 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 160378 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1'
using configuration from collection control_collection, trusted=true
[junit4] 2> 160378 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.control_collection.shard1.replica_n1' (registry
'solr.core.control_collection.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 160383 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 160383 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore
at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/control-001/cores/control_collection_shard1_replica_n1],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 160386 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=28, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=13.9189453125,
floorSegmentMB=0.3515625, forceMergeDeletesPctAllowed=15.885781921769365,
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6980662586473276
[junit4] 2> 160390 WARN (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 160427 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 160427 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 160428 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 160428 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 160429 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5389223065436952]
[junit4] 2> 160429 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@3c80c8da[control_collection_shard1_replica_n1] main]
[junit4] 2> 160431 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 160431 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 160432 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 160432 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1590219613158768640
[junit4] 2> 160432 INFO
(searcherExecutor-409-thread-1-processing-n:127.0.0.1:42492_igs%2Fuc
x:control_collection_shard1_replica_n1 s:shard1 c:control_collection)
[n:127.0.0.1:42492_igs%2Fuc c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore
[control_collection_shard1_replica_n1] Registered new searcher
Searcher@3c80c8da[control_collection_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 160437 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 160437 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 160437 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:42492/igs/uc/control_collection_shard1_replica_n1/
[junit4] 2> 160437 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 160437 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SyncStrategy
https://127.0.0.1:42492/igs/uc/control_collection_shard1_replica_n1/ has no
replicas
[junit4] 2> 160437 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 160441 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:42492/igs/uc/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 160544 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/control_collection/state.json] for collection
[control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 160593 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 160596 INFO (qtp1380590914-791) [n:127.0.0.1:42492_igs%2Fuc
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1357
[junit4] 2> 160601 INFO (qtp1380590914-793) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 30 seconds. Check all shard replicas
[junit4] 2> 160697 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/control_collection/state.json] for collection
[control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 161124 INFO
(OverseerCollectionConfigSetProcessor-99388725686697989-127.0.0.1:42492_igs%2Fuc-n_0000000000)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 161603 INFO (qtp1380590914-793) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:42492_igs%252Fuc&wt=javabin&version=2}
status=0 QTime=2485
[junit4] 2> 161615 INFO (zkConnectionManagerCallback-157-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 161619 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 161621 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58082/solr ready
[junit4] 2> 161624 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 161634 INFO (qtp1380590914-786) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 161640 INFO
(OverseerThreadFactory-406-thread-2-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.a.c.CreateCollectionCmd Create
collection collection1
[junit4] 2> 161643 WARN
(OverseerThreadFactory-406-thread-2-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.a.c.CreateCollectionCmd It is unusual
to create a collection (collection1) without cores.
[junit4] 2> 161853 INFO (qtp1380590914-786) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 30 seconds. Check all shard replicas
[junit4] 2> 161854 INFO (qtp1380590914-786) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2}
status=0 QTime=219
[junit4] 2> 161981 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-1-001
of type NRT
[junit4] 2> 161984 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.Server
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T11:27:37-10:00, git hash:
82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 161985 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 161985 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
No SessionScavenger set, using defaults
[junit4] 2> 161985 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
Scavenging every 660000ms
[junit4] 2> 161985 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@28a30236{/igs/uc,null,AVAILABLE}
[junit4] 2> 161986 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@422a5d5b{SSL,[ssl,
http/1.1]}{127.0.0.1:65525}
[junit4] 2> 161986 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.Server
Started @164323ms
[junit4] 2> 161986 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/igs/uc, hostPort=65525,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-1-001/cores}
[junit4] 2> 161986 ERROR
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 161986 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 161986 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 161986 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 161986 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-21T16:20:04.069Z
[junit4] 2> 161991 INFO (zkConnectionManagerCallback-159-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 161993 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 161993 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-1-001/solr.xml
[junit4] 2> 161997 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 161997 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 161997 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 161999 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58082/solr
[junit4] 2> 162003 INFO (zkConnectionManagerCallback-163-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 162010 INFO
(zkConnectionManagerCallback-165-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc)
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ConnectionManager zkClient has
connected
[junit4] 2> 162017 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (1)
[junit4] 2> 162020 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 162023 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:65525_igs%2Fuc
[junit4] 2> 162024 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (1) -> (2)
[junit4] 2> 162033 INFO (zkCallback-156-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 162033 INFO
(zkCallback-164-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc)
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (1) -> (2)
[junit4] 2> 162110 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 162117 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 162117 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 162118 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-1-001/cores
[junit4] 2> 162139 INFO (qtp1380590914-793) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
node=127.0.0.1:65525_igs%252Fuc&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 162142 INFO
(OverseerCollectionConfigSetProcessor-99388725686697989-127.0.0.1:42492_igs%2Fuc-n_0000000000)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 162144 INFO
(OverseerThreadFactory-406-thread-3-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.a.c.AddReplicaCmd Node Identified
127.0.0.1:65525_igs%2Fuc for creating new replica
[junit4] 2> 162167 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 162168 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 162272 INFO
(zkCallback-164-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc)
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 163183 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 163191 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema
[collection1_shard2_replica_n41] Schema name=test
[junit4] 2> 163259 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 163279 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard2_replica_n41' using configuration from
collection collection1, trusted=true
[junit4] 2> 163279 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard2.replica_n41' (registry
'solr.core.collection1.shard2.replica_n41') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 163279 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 163279 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrCore
[[collection1_shard2_replica_n41] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-1-001/cores/collection1_shard2_replica_n41],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-1-001/cores/collection1_shard2_replica_n41/data/]
[junit4] 2> 163281 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=28, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=13.9189453125,
floorSegmentMB=0.3515625, forceMergeDeletesPctAllowed=15.885781921769365,
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6980662586473276
[junit4] 2> 163285 WARN (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 163344 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 163344 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 163345 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 163345 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 163346 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5389223065436952]
[junit4] 2> 163346 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@4cae8af0[collection1_shard2_replica_n41] main]
[junit4] 2> 163350 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 163351 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 163351 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 163352 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1590219616220610560
[junit4] 2> 163352 INFO
(searcherExecutor-420-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc
x:collection1_shard2_replica_n41 s:shard2 c:collection1)
[n:127.0.0.1:65525_igs%2Fuc c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.SolrCore
[collection1_shard2_replica_n41] Registered new searcher
Searcher@4cae8af0[collection1_shard2_replica_n41]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 163357 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 163357 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 163357 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy
Sync replicas to https://127.0.0.1:65525/igs/uc/collection1_shard2_replica_n41/
[junit4] 2> 163357 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 163357 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy
https://127.0.0.1:65525/igs/uc/collection1_shard2_replica_n41/ has no replicas
[junit4] 2> 163357 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 163361 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:65525/igs/uc/collection1_shard2_replica_n41/ shard2
[junit4] 2> 163502 INFO
(zkCallback-164-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc)
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 163503 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 163519 INFO (qtp2026262601-837) [n:127.0.0.1:65525_igs%2Fuc
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1351
[junit4] 2> 163525 INFO (qtp1380590914-793) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:65525_igs%252Fuc&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
status=0 QTime=1386
[junit4] 2> 163619 INFO
(zkCallback-164-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc)
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 163667 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-2-001
of type NRT
[junit4] 2> 163669 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.Server
jetty-9.4.8.v20171121, build timestamp: 2017-11-21T11:27:37-10:00, git hash:
82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 163671 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 163671 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
No SessionScavenger set, using defaults
[junit4] 2> 163671 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
Scavenging every 660000ms
[junit4] 2> 163671 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@44de1da5{/igs/uc,null,AVAILABLE}
[junit4] 2> 163672 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1a34d376{SSL,[ssl,
http/1.1]}{127.0.0.1:64475}
[junit4] 2> 163672 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.Server
Started @166009ms
[junit4] 2> 163672 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/tempDir-001/jetty2,
solrconfig=solrconfig.xml, hostContext=/igs/uc, hostPort=64475,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-2-001/cores}
[junit4] 2> 163672 ERROR
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 163672 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 163672 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 163673 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 163673 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-01-21T16:20:05.756Z
[junit4] 2> 163675 INFO (zkConnectionManagerCallback-169-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 163677 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 163677 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-2-001/solr.xml
[junit4] 2> 163681 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 163681 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 163681 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 163684 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58082/solr
[junit4] 2> 163686 INFO (zkConnectionManagerCallback-173-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 163694 INFO
(zkConnectionManagerCallback-175-thread-1-processing-n:127.0.0.1:64475_igs%2Fuc)
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.c.ConnectionManager zkClient has
connected
[junit4] 2> 163703 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (2)
[junit4] 2> 163706 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 163711 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:64475_igs%2Fuc
[junit4] 2> 163737 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (2) -> (3)
[junit4] 2> 163738 INFO
(zkCallback-174-thread-1-processing-n:127.0.0.1:64475_igs%2Fuc)
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (2) -> (3)
[junit4] 2> 163738 INFO (zkCallback-156-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 163738 INFO
(zkCallback-164-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc)
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (2) -> (3)
[junit4] 2> 163783 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 163789 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 163789 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 163790 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7])
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-2-001/cores
[junit4] 2> 163815 INFO (qtp1380590914-786) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
node=127.0.0.1:64475_igs%252Fuc&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 163819 INFO
(OverseerCollectionConfigSetProcessor-99388725686697989-127.0.0.1:42492_igs%2Fuc-n_0000000000)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 163820 INFO
(OverseerThreadFactory-406-thread-4-processing-n:127.0.0.1:42492_igs%2Fuc)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.a.c.AddReplicaCmd Node Identified
127.0.0.1:64475_igs%2Fuc for creating new replica
[junit4] 2> 163839 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n43&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 163839 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 163944 INFO
(zkCallback-164-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc)
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 163944 INFO
(zkCallback-174-thread-1-processing-n:127.0.0.1:64475_igs%2Fuc)
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 164857 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 164865 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.s.IndexSchema
[collection1_shard1_replica_n43] Schema name=test
[junit4] 2> 164925 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 164944 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard1_replica_n43' using configuration from
collection collection1, trusted=true
[junit4] 2> 164945 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard1.replica_n43' (registry
'solr.core.collection1.shard1.replica_n43') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@75a0629
[junit4] 2> 164945 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 164945 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SolrCore
[[collection1_shard1_replica_n43] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-2-001/cores/collection1_shard1_replica_n43],
dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.RollingRestartTest_4DD3A648D35DC9B7-001/shard-2-001/cores/collection1_shard1_replica_n43/data/]
[junit4] 2> 164947 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=28, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=13.9189453125,
floorSegmentMB=0.3515625, forceMergeDeletesPctAllowed=15.885781921769365,
segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6980662586473276
[junit4] 2> 164954 WARN (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 164994 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 164994 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 164994 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 164995 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 164996 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5389223065436952]
[junit4] 2> 164996 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@4661b9fa[collection1_shard1_replica_n43] main]
[junit4] 2> 164998 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 164998 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 164999 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 164999 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1590219617947615232
[junit4] 2> 165000 INFO
(searcherExecutor-431-thread-1-processing-n:127.0.0.1:64475_igs%2Fuc
x:collection1_shard1_replica_n43 s:shard1 c:collection1)
[n:127.0.0.1:64475_igs%2Fuc c:collection1 s:shard1
x:collection1_shard1_replica_n43] o.a.s.c.SolrCore
[collection1_shard1_replica_n43] Registered new searcher
Searcher@4661b9fa[collection1_shard1_replica_n43]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 165005 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 165006 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 165006 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SyncStrategy
Sync replicas to https://127.0.0.1:64475/igs/uc/collection1_shard1_replica_n43/
[junit4] 2> 165006 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 165006 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SyncStrategy
https://127.0.0.1:64475/igs/uc/collection1_shard1_replica_n43/ has no replicas
[junit4] 2> 165006 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 165012 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:64475/igs/uc/collection1_shard1_replica_n43/ shard1
[junit4] 2> 165115 INFO
(zkCallback-174-thread-1-processing-n:127.0.0.1:64475_igs%2Fuc)
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 165115 INFO
(zkCallback-164-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc)
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 165163 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 165167 INFO (qtp1587076867-874) [n:127.0.0.1:64475_igs%2Fuc
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n43&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1328
[junit4] 2> 165173 INFO (qtp1380590914-786) [n:127.0.0.1:42492_igs%2Fuc
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:64475_igs%252Fuc&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
status=0 QTime=1358
[junit4] 2> 165179 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 165179 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
collection1 failOnTimeout:true timeout (sec):330
[junit4] 2> 165267 INFO
(zkCallback-164-thread-1-processing-n:127.0.0.1:65525_igs%2Fuc)
[n:127.0.0.1:65525_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 165268 INFO
(zkCallback-174-thread-1-processing-n:127.0.0.1:64475_igs%2Fuc)
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.c.ZkStateReader A cluster state
change: [WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 165822 INFO
(OverseerCollectionConfigSetProcessor-99388725686697989-127.0.0.1:42492_igs%2Fuc-n_0000000000)
[n:127.0.0.1:42492_igs%2Fuc ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 166181 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
[junit4] 2> 166182 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.RollingRestartTest Current overseer leader = 127.0.0.1:42492_igs%2Fuc
[junit4] 1> / (11)
[junit4] 1> /configs (2)
[junit4] 1> /configs/_default (7)
[junit4] 1> /configs/_default/protwords.txt (0)
[junit4] 1> DATA: ...supressed...
[junit4] 1> /configs/_default/managed-schema (0)
[junit4] 1> DATA:
[junit4] 1> <?xml version="1.0" encoding="UTF-8" ?>
[junit4] 1> <!--
[junit4] 1> Licensed to the Apache Software Foundation (ASF) under
one or more
[junit4] 1> contributor license agreements. See the NOTICE file
distributed with
[junit4] 1> this work for additional information regarding
copyright ownership.
[junit4] 1> The ASF licenses this file to You under the Apache
License, Version 2.0
[junit4] 1> (the "License"); you may not use this file except in
compliance with
[junit4] 1> the License. You may obtain a copy of the License at
[junit4] 1>
[junit4] 1> http://www.apache.org/licenses/LICENSE-2.0
[junit4] 1>
[junit4] 1> Unless required by applicable law or agreed to in
writing, software
[junit4] 1> distributed under the License is distributed on an "AS
IS" BASIS,
[junit4] 1> WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either
express or implied.
[junit4] 1> See the License for the specific language governing
permissions and
[junit4] 1> limitations under the License.
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <!--
[junit4] 1>
[junit4] 1> This example schema is the recommended starting point
for users.
[junit4] 1> It should be kept correct and concise, usable
out-of-the-box.
[junit4] 1>
[junit4] 1>
[junit4] 1> For more information, on how to customize this file,
please see
[junit4] 1>
http://lucene.apache.org/solr/guide/documents-fields-and-schema-design.html
[junit4] 1>
[junit4] 1> PERFORMANCE NOTE: this schema includes many optional
features and should not
[junit4] 1> be used for benchmarking. To improve performance one
could
[junit4] 1> - set stored="false" for all fields possible (esp
large fields) when you
[junit4] 1> only need to search on the field but don't need to
return the original
[junit4] 1> value.
[junit4] 1> - set indexed="false" if you don't need to search on
the field, but only
[junit4] 1> return the field as a result of searching on other
indexed fields.
[junit4] 1> - remove all unneeded copyField statements
[junit4] 1> - for best index size and searching performance, set
"index" to false
[junit4] 1> for all general text fields, use copyField to copy
them to the
[junit4] 1> catchall "text" field, and use that for searching.
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <schema name="default-config" version="1.6">
[junit4] 1> <!-- attribute "name" is the name of this schema
and is only used for display purposes.
[junit4] 1> version="x.y" is Solr's version number for the
schema syntax and
[junit4] 1> semantics. It should not normally be changed by
applications.
[junit4] 1>
[junit4] 1> 1.0: multiValued attribute did not exist, all
fields are multiValued
[junit4] 1> by nature
[junit4] 1> 1.1: multiValued attribute introduced, false by
default
[junit4] 1> 1.2: omitTermFreqAndPositions attribute
introduced, true by default
[junit4] 1> except for text fields.
[junit4] 1> 1.3: removed optional field compress feature
[junit4] 1> 1.4: autoGeneratePhraseQueries attribute
introduced to drive QueryParser
[junit4] 1> behavior when a single string produces
multiple tokens. Defaults
[junit4] 1> to off for version >= 1.4
[junit4] 1> 1.5: omitNorms defaults to true for primitive
field types
[junit4] 1> (int, float, boolean, string...)
[junit4] 1> 1.6: useDocValuesAsStored defaults to true.
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <!-- Valid attributes for fields:
[junit4] 1> name: mandatory - the name for the field
[junit4] 1> type: mandatory - the name of a field type from
the
[junit4] 1> fieldTypes section
[junit4] 1> indexed: true if this field should be indexed
(searchable or sortable)
[junit4] 1> stored: true if this field should be retrievable
[junit4] 1> docValues: true if this field should have doc
values. Doc Values is
[junit4] 1> recommended (required, if you are using *Point
fields) for faceting,
[junit4] 1> grouping, sorting and function queries. Doc
Values will make the index
[junit4] 1> faster to load, more NRT-friendly and more
memory-efficient.
[junit4] 1> They are currently only supported by StrField,
UUIDField, all
[junit4] 1> *PointFields, and depending on the field type,
they might require
[junit4] 1> the field to be single-valued, be required or
have a default value
[junit4] 1> (check the documentation of the field type
you're interested in for
[junit4] 1> more information)
[junit4] 1> multiValued: true if this field may contain
multiple values per document
[junit4] 1> omitNorms: (expert) set to true to omit the norms
associated with
[junit4] 1> this field (this disables length normalization
and index-time
[junit4] 1> boosting for the field, and saves some memory).
Only full-text
[junit4] 1> fields or fields that need an index-time boost
need norms.
[junit4] 1> Norms are omitted for primitive (non-analyzed)
types by default.
[junit4] 1> termVectors: [false] set to true to store the term
vector for a
[junit4] 1> given field.
[junit4] 1> When using MoreLikeThis, fields used for
similarity should be
[junit4] 1> stored for best performance.
[junit4] 1> termPositions: Store position information with the
term vector.
[junit4] 1> This will increase storage costs.
[junit4] 1> termOffsets: Store offset information with the
term vector. This
[junit4] 1> will increase storage costs.
[junit4] 1> required: The field is required. It will throw an
error if the
[junit4] 1> value does not exist
[junit4] 1> default: a value that should be used if no value
is specified
[junit4] 1> when adding a document.
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <!-- field names should consist of alphanumeric or
underscore characters only and
[junit4] 1> not start with a digit. This is not currently
strictly enforced,
[junit4] 1> but other field names will not have first class
support from all components
[junit4] 1> and back compatibility is not guaranteed. Names
with both leading and
[junit4] 1> trailing underscores (e.g. _version_) are
reserved.
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <!-- In this _default configset, only four fields
are pre-declared:
[junit4] 1> id, _version_, and _text_ and _root_. All
other fields will be type guessed and added via the
[junit4] 1> "add-unknown-fields-to-the-schema" update
request processor chain declared in solrconfig.xml.
[junit4] 1>
[junit4] 1> Note that many dynamic fields are also defined
- you can use them to specify a
[junit4] 1> field's type via field naming conventions -
see below.
[junit4] 1>
[junit4] 1> WARNING: The _text_ catch-all field will
significantly increase your index size.
[junit4] 1> If you don't need it, consider removing it and
the corresponding copyField directive.
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <field name="id" type="string" indexed="true"
stored="true" required="true" multiValued="false" />
[junit4] 1> <!-- docValues are enabled by default for long type
so we don't need to index the version field -->
[junit4] 1> <field name="_version_" type="plong"
indexed="false" stored="false"/>
[junit4] 1> <field name="_root_" type="string" indexed="true"
stored="false" docValues="false" />
[junit4] 1> <field name="_text_" type="text_general"
indexed="true" stored="false" multiValued="true"/>
[junit4] 1>
[junit4] 1> <!-- This can be enabled, in case the client does
not know what fields may be searched. It isn't enabled by default
[junit4] 1> because it's very expensive to index
everything twice. -->
[junit4] 1> <!-- <copyField source="*" dest="_text_"/> -->
[junit4] 1>
[junit4] 1> <!-- Dynamic field definitions allow using
convention over configuration
[junit4] 1> for fields via the specification of patterns to
match field names.
[junit4] 1> EXAMPLE: name="*_i" will match any field ending
in _i (like myid_i, z_i)
[junit4] 1> RESTRICTION: the glob-like pattern in the name
attribute must have a "*" only at the start or the end. -->
[junit4] 1>
[junit4] 1> <dynamicField name="*_i" type="pint"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_is" type="pints"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_s" type="string"
indexed="true" stored="true" />
[junit4] 1> <dynamicField name="*_ss" type="strings"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_l" type="plong"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_ls" type="plongs"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_txt" type="text_general"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_b" type="boolean"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_bs" type="booleans"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_f" type="pfloat"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_fs" type="pfloats"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_d" type="pdouble"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_ds" type="pdoubles"
indexed="true" stored="true"/>
[junit4] 1>
[junit4] 1> <!-- Type used for data-driven schema, to add a
string copy for each text field -->
[junit4] 1> <dynamicField name="*_str" type="strings"
stored="false" docValues="true" indexed="false" />
[junit4] 1>
[junit4] 1> <dynamicField name="*_dt" type="pdate"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_dts" type="pdate"
indexed="true" stored="true" multiValued="true"/>
[junit4] 1> <dynamicField name="*_p" type="location"
indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_srpt" type="location_rpt"
indexed="true" stored="true"/>
[junit4] 1>
[junit4] 1> <!-- payloaded dynamic fields -->
[junit4] 1> <dynamicField name="*_dpf"
type="delimited_payloads_float" indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_dpi"
type="delimited_payloads_int" indexed="true" stored="true"/>
[junit4] 1> <dynamicField name="*_dps"
type="delimited_payloads_string" indexed="true" stored="true"/>
[junit4] 1>
[junit4] 1> <dynamicField name="attr_*" type="text_general"
indexed="true" stored="true" multiValued="true"/>
[junit4] 1>
[junit4] 1> <!-- Field to use to determine and enforce document
uniqueness.
[junit4] 1> Unless this field is marked with
required="false", it will be a required field
[junit4] 1> -->
[junit4] 1> <uniqueKey>id</uniqueKey>
[junit4] 1>
[junit4] 1> <!-- copyField commands copy one field to another
at the time a document
[junit4] 1> is added to the index. It's used either to
index the same field differently,
[junit4] 1> or to add multiple fields to the same field for
easier/faster searching.
[junit4] 1>
[junit4] 1> <copyField source="sourceFieldName"
dest="destinationFieldName"/>
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <!-- field type definitions. The "name" attribute is
[junit4] 1> just a label to be used by field definitions.
The "class"
[junit4] 1> attribute and any other attributes determine the
real
[junit4] 1> behavior of the fieldType.
[junit4] 1> Class names starting with "solr" refer to java
classes in a
[junit4] 1> standard package such as org.apache.solr.analysis
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <!-- sortMissingLast and sortMissingFirst
attributes are optional attributes are
[junit4] 1> currently supported on types that are sorted
internally as strings
[junit4] 1> and on numeric types.
[junit4] 1> This includes "string", "boolean", "pint",
"pfloat", "plong", "pdate", "pdouble".
[junit4] 1> - If sortMissingLast="true", then a sort on this
field will cause documents
[junit4] 1> without the field to come after documents with
the field,
[junit4] 1> regardless of the requested sort order (asc or
desc).
[junit4] 1> - If sortMissingFirst="true", then a sort on
this field will cause documents
[junit4] 1> without the field to come before documents
with the field,
[junit4] 1> regardless of the requested sort order.
[junit4] 1> - If sortMissingLast="false" and
sortMissingFirst="false" (the default),
[junit4] 1> then default lucene sorting will be used which
places docs without the
[junit4] 1> field first in an ascending sort and last in a
descending sort.
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <!-- The StrField type is not analyzed, but
indexed/stored verbatim. -->
[junit4] 1> <fieldType name="string" class="solr.StrField"
sortMissingLast="true" docValues="true" />
[junit4] 1> <fieldType name="strings" class="solr.StrField"
sortMissingLast="true" multiValued="true" docValues="true" />
[junit4] 1>
[junit4] 1> <!-- boolean type: "true" or "false" -->
[junit4] 1> <fieldType name="boolean" class="solr.BoolField"
sortMissingLast="true"/>
[junit4] 1> <fieldType name="booleans" class="solr.BoolField"
sortMissingLast="true" multiValued="true"/>
[junit4] 1>
[junit4] 1> <!--
[junit4] 1> Numeric field types that index values using
KD-trees.
[junit4] 1> Point fields don't support FieldCache, so they
must have docValues="true" if needed for sorting, faceting, functions, etc.
[junit4] 1> -->
[junit4] 1> <fieldType name="pint" class="solr.IntPointField"
docValues="true"/>
[junit4] 1> <fieldType name="pfloat"
class="solr.FloatPointField" docValues="true"/>
[junit4] 1> <fieldType name="plong" class="solr.LongPointField"
docValues="true"/>
[junit4] 1> <fieldType name="pdouble"
class="solr.DoublePointField" docValues="true"/>
[junit4] 1>
[junit4] 1> <fieldType name="pints" class="solr.IntPointField"
docValues="true" multiValued="true"/>
[junit4] 1> <fieldType name="pfloats"
class="solr.FloatPointField" docValues="true" multiValued="true"/>
[junit4] 1> <fieldType name="plongs"
class="solr.LongPointField" docValues="true" multiValued="true"/>
[junit4] 1> <fieldType name="pdoubles"
class="solr.DoublePointField" docValues="true" multiValued="true"/>
[junit4] 1>
[junit4] 1> <!-- The format for this date field is of the form
1995-12-31T23:59:59Z, and
[junit4] 1> is a more restricted form of the canonical
representation of dateTime
[junit4] 1> http://www.w3.org/TR/xmlschema-2/#dateTime
[junit4] 1> The trailing "Z" designates UTC time and is
mandatory.
[junit4] 1> Optional fractional seconds are allowed:
1995-12-31T23:59:59.999Z
[junit4] 1> All other components are mandatory.
[junit4] 1>
[junit4] 1> Expressions can also be used to denote
calculations that should be
[junit4] 1> performed relative to "NOW" to determine the
value, ie...
[junit4] 1>
[junit4] 1> NOW/HOUR
[junit4] 1> ... Round to the start of the current
hour
[junit4] 1> NOW-1DAY
[junit4] 1> ... Exactly 1 day prior to now
[junit4] 1> NOW/DAY+6MONTHS+3DAYS
[junit4] 1> ... 6 months and 3 days in the future
from the start of
[junit4] 1> the current day
[junit4] 1>
[junit4] 1> -->
[junit4] 1> <!-- KD-tree versions of date fields -->
[junit4] 1> <fieldType name="pdate" class="solr.DatePointField"
docValues="true"/>
[junit4] 1> <fieldType name="pdates"
class="solr.DatePointField" docValues="true" multiValued="true"/>
[junit4] 1>
[junit4] 1> <!--Binary data type. The data should be
sent/retrieved in as Base64 encoded Strings -->
[junit4] 1> <fieldType name="binary" class="solr.BinaryField"/>
[junit4] 1>
[junit4] 1> <!-- solr.TextField allows the specification of
custom text analyzers
[junit4] 1> specified as a tokenizer and a list of token
filters. Different
[junit4] 1> analyzers may be specified for indexing and
querying.
[junit4] 1>
[junit4] 1> The optional positionIncrementGap puts space
between multiple fields of
[junit4] 1> this type on the same document, with the
purpose of preventing false phrase
[junit4] 1> matching across fields.
[junit4] 1>
[junit4] 1> For more info on customizing your analyzer
chain, please see
[junit4] 1>
http://lucene.apache.org/solr/guide/understanding-analyzers-tokenizers-and-filters.html#understanding-analyzers-tokenizers-and-filters
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <!-- One can also specify an existing Analyzer
class that has a
[junit4] 1> default constructor via the class attribute on
the analyzer element.
[junit4] 1> Example:
[junit4] 1> <fieldType name="text_greek" class="solr.TextField">
[junit4] 1> <analyzer
class="org.apache.lucene.analysis.el.GreekAnalyzer"/>
[junit4] 1> </fieldType>
[junit4] 1> -->
[junit4] 1>
[junit4] 1> <!-- A text field that only splits on whitespace
for exact matching of words -->
[junit4] 1> <dynamicField name="*_ws" type="text_ws"
indexed="true" stored="true"/>
[junit4] 1> <fieldType name="text_ws" class="solr.TextField"
positionIncrementGap="100">
[junit4] 1> <analyzer>
[junit4] 1> <tokenizer
class="solr.WhitespaceTokenizerFactory"/>
[junit4] 1> </analyzer>
[junit4] 1> </fieldType>
[junit4] 1>
[junit4] 1> <!-- A general text field that has reasonable,
generic
[junit4] 1> cross-language defaults: it tokenizes with
StandardTokenizer,
[junit4] 1> removes stop words from case-insensitive
"stopwords.txt"
[junit4] 1> (empty by default), and down cases. At
query time only, it
[junit4] 1> also applies synonyms.
[junit4] 1> -->
[junit4] 1> <fieldType name="text_general"
class="solr.TextField" positionIncrementGap="100" multiValued="true">
[junit4] 1> <analyzer type="index">
[junit4] 1> <tokenizer
class="solr.StandardTokenizerFactory"/>
[junit4] 1> <filter class="solr.StopFilterFactory"
ignoreCase="true" words="stopwords.txt" />
[junit4] 1> <!-- in this example, we will only use synonyms
at query time
[junit4] 1>
[...truncated too long message...]
ale.metrics.MetricRegistry@245d83c2
[junit4] 2> 210101 INFO
(zkCallback-174-thread-2-processing-n:127.0.0.1:64475_igs%2Fuc)
[n:127.0.0.1:64475_igs%2Fuc ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (1) -> (0)
[junit4] 2> 210101 INFO (zkCallback-156-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 210105 INFO (coreCloseExecutor-544-thread-1)
[n:127.0.0.1:64475_igs%2Fuc c:collection1 s:shard1 r:core_node44
x:collection1_shard1_replica_n43] o.a.s.m.SolrMetricManager Closing metric
reporters for registry=solr.collection.collection1.shard1.leader, tag=673836824
[junit4] 2> 210110 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 0x1611984f93c000d, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 210113 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@1a34d376{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 210113 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@44de1da5{/igs/uc,null,UNAVAILABLE}
[junit4] 2> 210113 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ] o.e.j.s.session
Stopped scavenging
[junit4] 2> 210119 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.ChaosMonkey monkey: stop jetty! 42492
[junit4] 2> 210119 ERROR
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 210122 INFO
(TEST-RollingRestartTest.test-seed#[4DD3A648D35DC9B7]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:58082 58082
[junit4] 2> 210166 INFO (Thread-122) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:58082 58082
[junit4] 2> 210167 WARN (Thread-122) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 9 /solr/aliases.json
[junit4] 2> 7 /solr/security.json
[junit4] 2> 7 /solr/configs/conf1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 14 /solr/autoscaling.json
[junit4] 2> 9 /solr/clusterprops.json
[junit4] 2> 9 /solr/clusterstate.json
[junit4] 2> 6 /solr/collections/collection1/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 14 /solr/overseer/queue-work
[junit4] 2> 12 /solr/autoscaling/events/.auto_add_replicas
[junit4] 2> 10 /solr/overseer/collection-queue-work
[junit4] 2> 9 /solr/live_nodes
[junit4] 2> 9 /solr/collections
[junit4] 2> 5 /solr/overseer/queue
[junit4] 2>
[junit4] 2> 210168 INFO
(SUITE-RollingRestartTest-seed#[4DD3A648D35DC9B7]-worker) [ ]
o.a.s.SolrTestCaseJ4 -------------------------------------------------------
Done waiting for tracked resources to be released
[junit4] 2> Jan 21, 2018 4:20:52 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked
thread(s).
[junit4] 2> Jan 21, 2018 4:21:12 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at
org.apache.solr.cloud.RollingRestartTest:
[junit4] 2> 1) Thread[id=978, name=qtp1660790768-978,
state=TIMED_WAITING, group=TGRP-RollingRestartTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
[junit4] 2> at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
[junit4] 2> at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> Jan 21, 2018 4:21:12 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=978, name=qtp1660790768-978,
state=TIMED_WAITING, group=TGRP-RollingRestartTest]
[junit4] 2> Jan 21, 2018 4:21:15 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> SEVERE: There are still zombie threads that couldn't be
terminated:
[junit4] 2> 1) Thread[id=978, name=qtp1660790768-978,
state=TIMED_WAITING, group=TGRP-RollingRestartTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
[junit4] 2> at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
[junit4] 2> at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=1273, maxMBSortInHeap=7.242748469927479,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@f01e7a7),
locale=ca, timezone=Pacific/Truk
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_152
(64-bit)/cpus=3,threads=2,free=32510888,total=320864256
[junit4] 2> NOTE: All tests run in this JVM: [SubstringBytesRefFilterTest,
TestExtendedDismaxParser, TestCloudPseudoReturnFields,
CachingDirectoryFactoryTest, TermVectorComponentTest,
CollectionsAPIDistributedZkTest, TestSolrIndexConfig, SortByFunctionTest,
TestShardHandlerFactory, CdcrReplicationDistributedZkTest,
TestQueryWrapperFilter, TestPerFieldSimilarityWithDefaultOverride,
CoreAdminHandlerTest, RollingRestartTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=RollingRestartTest
-Dtests.seed=4DD3A648D35DC9B7 -Dtests.slow=true -Dtests.locale=ca
-Dtests.timezone=Pacific/Truk -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J1 | RollingRestartTest (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.RollingRestartTest:
[junit4] > 1) Thread[id=978, name=qtp1660790768-978,
state=TIMED_WAITING, group=TGRP-RollingRestartTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
[junit4] > at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
[junit4] > at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
[junit4] > at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
[junit4] > at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at
__randomizedtesting.SeedInfo.seed([4DD3A648D35DC9B7]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=978, name=qtp1660790768-978,
state=TIMED_WAITING, group=TGRP-RollingRestartTest]
[junit4] > at sun.misc.Unsafe.park(Native Method)
[junit4] > at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] > at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
[junit4] > at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
[junit4] > at
org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
[junit4] > at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
[junit4] > at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] > at
__randomizedtesting.SeedInfo.seed([4DD3A648D35DC9B7]:0)
[junit4] Completed [41/768 (1!)] on J1 in 75.12s, 1 test, 2 errors <<<
FAILURES!
[...truncated 50407 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
