Build: https://builds.apache.org/job/Lucene-Solr-Tests-8.x/823/
2 tests failed.
FAILED: org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest.test
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([69F495BA089935F5]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([69F495BA089935F5]:0)
Build Log:
[...truncated 16495 lines...]
[junit4] Suite: org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
[junit4] 2> 2414671 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[69F495BA089935F5]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/data-dir-199-001
[junit4] 2> 2414671 WARN
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[69F495BA089935F5]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=10 numCloses=10
[junit4] 2> 2414671 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[69F495BA089935F5]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2414673 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[69F495BA089935F5]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 2414673 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[69F495BA089935F5]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2414673 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[69F495BA089935F5]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property:
/ct_em/d
[junit4] 2> 2414695 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2414704 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2414704 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2414802 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer start zk server on port:44024
[junit4] 2> 2414802 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:44024
[junit4] 2> 2414802 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:44024
[junit4] 2> 2414802 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 44024
[junit4] 2> 2414804 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2414811 INFO (zkConnectionManagerCallback-7969-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2414811 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2414818 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2414820 INFO (zkConnectionManagerCallback-7971-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2414820 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2414822 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2414823 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 2414824 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2414825 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2414826 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2414830 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2414832 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2414833 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2414834 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2414835 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2414836 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkTestServer put
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2414837 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly
asked otherwise
[junit4] 2> 2414966 WARN
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 2414966 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2414966 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2414966 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git:
363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
[junit4] 2> 2414967 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2414967 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2414967 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2414968 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6a1ecf3d{/ct_em/d,null,AVAILABLE}
[junit4] 2> 2414969 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7226b882{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:34673}
[junit4] 2> 2414969 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.s.Server Started @2415029ms
[junit4] 2> 2414969 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/tempDir-001/control/data,
hostContext=/ct_em/d, hostPort=34673,
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/control-001/cores}
[junit4] 2> 2414969 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2414969 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2414969 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.5.0
[junit4] 2> 2414969 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2414969 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2414969 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-12-31T13:00:33.846Z
[junit4] 2> 2414971 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2414971 INFO (zkConnectionManagerCallback-7973-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2414972 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2415073 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2415073 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/control-001/solr.xml
[junit4] 2> 2415077 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2415077 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2415078 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2415184 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2415185 WARN
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@7fd42bcb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2415185 WARN
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@7fd42bcb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2415188 WARN
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@28251bb3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2415188 WARN
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@28251bb3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2415189 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44024/solr
[junit4] 2> 2415189 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2415190 INFO (zkConnectionManagerCallback-7980-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2415191 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2415293 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.c.ConnectionManager Waiting for
client to connect to ZooKeeper
[junit4] 2> 2415294 INFO (zkConnectionManagerCallback-7982-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2415294 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.c.ConnectionManager Client is
connected to ZooKeeper
[junit4] 2> 2415397 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.OverseerElectionContext I am going
to be the leader 127.0.0.1:34673_ct_em%2Fd
[junit4] 2> 2415398 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.Overseer Overseer
(id=75998577446617092-127.0.0.1:34673_ct_em%2Fd-n_0000000000) starting
[junit4] 2> 2415410 INFO
(OverseerStateUpdate-75998577446617092-127.0.0.1:34673_ct_em%2Fd-n_0000000000)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.Overseer Starting to work on the
main queue : 127.0.0.1:34673_ct_em%2Fd
[junit4] 2> 2415410 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.ZkController Register node as live
in ZooKeeper:/live_nodes/127.0.0.1:34673_ct_em%2Fd
[junit4] 2> 2415411 INFO
(OverseerStateUpdate-75998577446617092-127.0.0.1:34673_ct_em%2Fd-n_0000000000)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (1)
[junit4] 2> 2415412 WARN
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.CoreContainer Not all security
plugins configured! authentication=disabled authorization=disabled. Solr is
only as secure as you make it. Consider configuring
authentication/authorization before exposing Solr to users internal or
external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2415450 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 2415469 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2415478 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2415478 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2415480 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.p.PackageLoader /packages.json updated
to version -1
[junit4] 2> 2415481 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5])
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/control-001/cores
[junit4] 2> 2415501 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2415501 INFO (zkConnectionManagerCallback-7991-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2415501 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2415502 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2415503 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44024/solr ready
[junit4] 2> 2415504 INFO (qtp1017319686-23079)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.h.a.CollectionsHandler Invoked
Collection Action :create with params
collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:34673_ct_em%252Fd&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2415508 INFO
(OverseerThreadFactory-6873-thread-1-processing-n:127.0.0.1:34673_ct_em%2Fd)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.a.c.CreateCollectionCmd Create
collection control_collection
[junit4] 2> 2415615 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd x:control_collection_shard1_replica_n1 ]
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> 2415615 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd x:control_collection_shard1_replica_n1 ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 2416627 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 8.5.0
[junit4] 2> 2416641 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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> 2416709 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema
test/1.6 with uniqueid field id
[junit4] 2> 2416724 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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> 2416725 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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@6d92ba91
[junit4] 2> 2416725 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/control-001/cores/control_collection_shard1_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 2416728 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=42, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 2416737 WARN (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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> 2416781 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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> 2416781 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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> 2416782 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit:
if uncommitted for 15000ms;
[junit4] 2> 2416782 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 2416783 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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=32, maxMergeAtOnceExplicit=48,
maxMergedSegmentMB=25.9482421875, floorSegmentMB=1.9375,
forceMergeDeletesPctAllowed=1.730828506207206, segmentsPerTier=22.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5851214367745134,
deletesPctAllowed=32.366511292856444
[junit4] 2> 2416784 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening
[Searcher@52bda4f0[control_collection_shard1_replica_n1] main]
[junit4] 2> 2416786 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage
Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2416786 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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> 2416786 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits
will be reserved for 10000ms.
[junit4] 2> 2416786 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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 1654440314182565888
[junit4] 2> 2416790 INFO
(searcherExecutor-6878-thread-1-processing-n:127.0.0.1:34673_ct_em%2Fd
x:control_collection_shard1_replica_n1 c:control_collection s:shard1)
[n:127.0.0.1:34673_ct_em%2Fd 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@52bda4f0[control_collection_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2416792 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update
of terms at /collections/control_collection/terms/shard1 to
Terms{values={core_node2=0}, version=0}
[junit4] 2> 2416792 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase
make sure parent is created /collections/control_collection/leaders/shard1
[junit4] 2> 2416795 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext
Enough replicas found to continue.
[junit4] 2> 2416795 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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> 2416795 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:34673/ct_em/d/control_collection_shard1_replica_n1/
[junit4] 2> 2416795 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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> 2416796 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy
http://127.0.0.1:34673/ct_em/d/control_collection_shard1_replica_n1/ has no
replicas
[junit4] 2> 2416796 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] 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/75998577446617092-core_node2-n_0000000000
[junit4] 2> 2416797 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I
am the new leader:
http://127.0.0.1:34673/ct_em/d/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 2416899 INFO (zkCallback-7981-thread-1) [ ]
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> 2416899 INFO (zkCallback-7981-thread-2) [ ]
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> 2416900 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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> 2416902 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd 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=1287
[junit4] 2> 2416904 INFO (qtp1017319686-23079)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.h.a.CollectionsHandler Wait for new
collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 2417002 INFO (zkCallback-7981-thread-2) [ ]
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> 2417002 INFO (zkCallback-7981-thread-3) [ ]
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> 2417002 INFO (zkCallback-7981-thread-1) [ ]
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> 2417003 INFO (qtp1017319686-23079)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:34673_ct_em%252Fd&wt=javabin&version=2}
status=0 QTime=1498
[junit4] 2> 2417003 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in
collection: control_collection
[junit4] 2> 2417108 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2417109 INFO (zkConnectionManagerCallback-7997-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2417109 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2417110 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2417111 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:44024/solr ready
[junit4] 2> 2417111 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 2417112 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.h.a.CollectionsHandler Invoked
Collection Action :create with params
collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2417115 INFO
(OverseerThreadFactory-6873-thread-2-processing-n:127.0.0.1:34673_ct_em%2Fd)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.a.c.CreateCollectionCmd Create
collection collection1
[junit4] 2> 2417115 INFO
(OverseerCollectionConfigSetProcessor-75998577446617092-127.0.0.1:34673_ct_em%2Fd-n_0000000000)
[n:127.0.0.1:34673_ct_em%2Fd ] 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> 2417328 WARN
(OverseerThreadFactory-6873-thread-2-processing-n:127.0.0.1:34673_ct_em%2Fd)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.c.a.c.CreateCollectionCmd It is
unusual to create a collection (collection1) without cores.
[junit4] 2> 2417329 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.h.a.CollectionsHandler Wait for new
collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 2417330 INFO (qtp1017319686-23081)
[n:127.0.0.1:34673_ct_em%2Fd ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=2&wt=javabin&version=2}
status=0 QTime=218
[junit4] 2> 2417331 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrCloudTestCase active slice count: 1 expected:1
[junit4] 2> 2417331 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 2417331 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrCloudTestCase active slice count: 1 expected:1
[junit4] 2> 2417331 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 2417332 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrCloudTestCase active slice count: 1 expected:1
[junit4] 2> 2417332 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 2417332 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances
pullReplicaCount=0 numOtherReplicas=3
[junit4] 2> 2417443 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-1-001
of type NRT
[junit4] 2> 2417444 WARN (closeThreadPool-7998-thread-1) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 2417444 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2417444 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2417444 INFO (closeThreadPool-7998-thread-1) [ ]
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git:
363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
[junit4] 2> 2417445 INFO (closeThreadPool-7998-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2417445 INFO (closeThreadPool-7998-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2417445 INFO (closeThreadPool-7998-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2417446 INFO (closeThreadPool-7998-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7fb6f2b3{/ct_em/d,null,AVAILABLE}
[junit4] 2> 2417446 INFO (closeThreadPool-7998-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@432aea30{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:38285}
[junit4] 2> 2417446 INFO (closeThreadPool-7998-thread-1) [ ]
o.e.j.s.Server Started @2417507ms
[junit4] 2> 2417446 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/ct_em/d, hostPort=38285,
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-1-001/cores}
[junit4] 2> 2417446 ERROR (closeThreadPool-7998-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2417446 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2417446 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.5.0
[junit4] 2> 2417447 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2417447 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2417447 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-12-31T13:00:36.324Z
[junit4] 2> 2417448 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2417448 INFO (zkConnectionManagerCallback-8000-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2417448 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2417550 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2417550 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-1-001/solr.xml
[junit4] 2> 2417554 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2417554 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2417556 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2417557 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-2-001
of type NRT
[junit4] 2> 2417558 WARN (closeThreadPool-7998-thread-2) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 2417558 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2417558 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2417558 INFO (closeThreadPool-7998-thread-2) [ ]
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git:
363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
[junit4] 2> 2417570 INFO (closeThreadPool-7998-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2417570 INFO (closeThreadPool-7998-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2417570 INFO (closeThreadPool-7998-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2417570 INFO (closeThreadPool-7998-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2a094a5e{/ct_em/d,null,AVAILABLE}
[junit4] 2> 2417571 INFO (closeThreadPool-7998-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@62bda4a0{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:34256}
[junit4] 2> 2417571 INFO (closeThreadPool-7998-thread-2) [ ]
o.e.j.s.Server Started @2417631ms
[junit4] 2> 2417571 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/tempDir-001/jetty2,
solrconfig=solrconfig.xml, hostContext=/ct_em/d, hostPort=34256,
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-2-001/cores}
[junit4] 2> 2417571 ERROR (closeThreadPool-7998-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2417571 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2417571 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.5.0
[junit4] 2> 2417571 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2417571 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2417571 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-12-31T13:00:36.448Z
[junit4] 2> 2417572 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2417574 INFO (zkConnectionManagerCallback-8003-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2417574 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2417675 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2417675 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-2-001/solr.xml
[junit4] 2> 2417679 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2417679 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2417706 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2417723 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-3-001
of type NRT
[junit4] 2> 2417734 WARN (closeThreadPool-7998-thread-3) [ ]
o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content,
break even is size 23
[junit4] 2> 2417734 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2417734 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2417734 INFO (closeThreadPool-7998-thread-3) [ ]
o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git:
363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_191-b12
[junit4] 2> 2417791 INFO (closeThreadPool-7998-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2417791 INFO (closeThreadPool-7998-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2417791 INFO (closeThreadPool-7998-thread-3) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2417794 INFO (closeThreadPool-7998-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@34299ad5{/ct_em/d,null,AVAILABLE}
[junit4] 2> 2417794 INFO (closeThreadPool-7998-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@378ce147{HTTP/1.1,[http/1.1,
h2c]}{127.0.0.1:44197}
[junit4] 2> 2417794 INFO (closeThreadPool-7998-thread-3) [ ]
o.e.j.s.Server Started @2417855ms
[junit4] 2> 2417794 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/tempDir-001/jetty3,
solrconfig=solrconfig.xml, hostContext=/ct_em/d, hostPort=44197,
coreRootDirectory=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-3-001/cores}
[junit4] 2> 2417794 ERROR (closeThreadPool-7998-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2417794 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2417795 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
8.5.0
[junit4] 2> 2417795 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2417795 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2417795 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-12-31T13:00:36.672Z
[junit4] 2> 2417806 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2417822 INFO (zkConnectionManagerCallback-8006-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2417822 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2417839 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2417840 WARN (closeThreadPool-7998-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@4f7be00a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2417840 WARN (closeThreadPool-7998-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@4f7be00a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2417859 WARN (closeThreadPool-7998-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@78c7b27f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2417859 WARN (closeThreadPool-7998-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@78c7b27f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2417860 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44024/solr
[junit4] 2> 2417867 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2417871 INFO (zkConnectionManagerCallback-8012-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2417871 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2417874 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2417874 WARN (closeThreadPool-7998-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@1dcc5958[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2417874 WARN (closeThreadPool-7998-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@1dcc5958[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2417876 WARN (closeThreadPool-7998-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@e3cceec[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2417876 WARN (closeThreadPool-7998-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@e3cceec[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2417877 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44024/solr
[junit4] 2> 2417879 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2417882 INFO (zkConnectionManagerCallback-8018-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2417882 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2417923 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2417923 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-3-001/solr.xml
[junit4] 2> 2417927 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 2417927 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2417928 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 2417974 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.c.c.ConnectionManager Waiting for
client to connect to ZooKeeper
[junit4] 2> 2417974 INFO (zkConnectionManagerCallback-8021-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2417975 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.c.c.ConnectionManager Client is
connected to ZooKeeper
[junit4] 2> 2418080 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2418080 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (1)
[junit4] 2> 2418080 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.c.c.ConnectionManager Waiting for
client to connect to ZooKeeper
[junit4] 2> 2418081 WARN (closeThreadPool-7998-thread-3) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@3b73d748[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2418081 WARN (closeThreadPool-7998-thread-3) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@3b73d748[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2418082 INFO (zkConnectionManagerCallback-8023-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2418082 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.c.c.ConnectionManager Client is
connected to ZooKeeper
[junit4] 2> 2418083 WARN (closeThreadPool-7998-thread-3) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@69762d69[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2418083 WARN (closeThreadPool-7998-thread-3) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@69762d69[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2418084 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:44024/solr
[junit4] 2> 2418084 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.c.ZkController Publish
node=127.0.0.1:38285_ct_em%2Fd as DOWN
[junit4] 2> 2418085 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2418085 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 2418085 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.c.ZkController Register node as live
in ZooKeeper:/live_nodes/127.0.0.1:38285_ct_em%2Fd
[junit4] 2> 2418085 INFO (zkConnectionManagerCallback-8033-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2418085 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2418087 INFO (zkCallback-7981-thread-4) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2418087 INFO (zkCallback-8020-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2418088 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (2)
[junit4] 2> 2418088 INFO (zkCallback-7996-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2418088 WARN (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.c.CoreContainer Not all security
plugins configured! authentication=disabled authorization=disabled. Solr is
only as secure as you make it. Consider configuring
authentication/authorization before exposing Solr to users internal or
external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2418091 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.c.ZkController Publish
node=127.0.0.1:34256_ct_em%2Fd as DOWN
[junit4] 2> 2418092 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 2418092 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.c.ZkController Register node as live
in ZooKeeper:/live_nodes/127.0.0.1:34256_ct_em%2Fd
[junit4] 2> 2418093 INFO (zkCallback-7981-thread-4) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2418093 INFO (zkCallback-8022-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2418093 INFO (zkCallback-8020-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2418094 WARN (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.c.CoreContainer Not all security
plugins configured! authentication=disabled authorization=disabled. Solr is
only as secure as you make it. Consider configuring
authentication/authorization before exposing Solr to users internal or
external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2418105 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 2418110 INFO (zkCallback-7996-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2418118 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 2418125 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2418135 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2418135 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2418136 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.p.PackageLoader /packages.json updated
to version -1
[junit4] 2> 2418137 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2418137 INFO (closeThreadPool-7998-thread-2)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-2-001/cores
[junit4] 2> 2418146 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2418146 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2418148 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.p.PackageLoader /packages.json updated
to version -1
[junit4] 2> 2418149 INFO (closeThreadPool-7998-thread-1)
[n:127.0.0.1:38285_ct_em%2Fd ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-1-001/cores
[junit4] 2> 2418165 INFO (closeThreadPool-7998-thread-2) [ ]
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:34256_ct_em%2Fd
[junit4] 2> 2418188 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.c.c.ConnectionManager Waiting for
client to connect to ZooKeeper
[junit4] 2> 2418189 INFO (zkConnectionManagerCallback-8039-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2418189 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.c.c.ConnectionManager Client is
connected to ZooKeeper
[junit4] 2> 2418193 INFO (closeThreadPool-7998-thread-1) [ ]
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:38285_ct_em%2Fd
[junit4] 2> 2418194 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (3)
[junit4] 2> 2418198 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.c.ZkController Publish
node=127.0.0.1:44197_ct_em%2Fd as DOWN
[junit4] 2> 2418199 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 2418199 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.c.ZkController Register node as live
in ZooKeeper:/live_nodes/127.0.0.1:44197_ct_em%2Fd
[junit4] 2> 2418200 INFO (zkCallback-8020-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2418200 INFO (zkCallback-8022-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2418200 INFO (zkCallback-7996-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2418203 INFO (zkCallback-7981-thread-4) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2418204 INFO (zkCallback-8038-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2418204 WARN (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.c.CoreContainer Not all security
plugins configured! authentication=disabled authorization=disabled. Solr is
only as secure as you make it. Consider configuring
authentication/authorization before exposing Solr to users internal or
external. See https://s.apache.org/solrsecurity for more info
[junit4] 2> 2418219 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 2418238 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2418258 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2418258 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2418260 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.p.PackageLoader /packages.json updated
to version -1
[junit4] 2> 2418261 INFO (closeThreadPool-7998-thread-3)
[n:127.0.0.1:44197_ct_em%2Fd ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-3-001/cores
[junit4] 2> 2418296 INFO (closeThreadPool-7998-thread-3) [ ]
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:44197_ct_em%2Fd
[junit4] 2> 2418299 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.h.a.CollectionsHandler Invoked
Collection Action :addreplica with params
node=127.0.0.1:38285_ct_em%252Fd&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2418299 INFO (qtp1719811240-23145)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.h.a.CollectionsHandler Invoked
Collection Action :addreplica with params
node=127.0.0.1:34256_ct_em%252Fd&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2418299 INFO (qtp1719811240-23149)
[n:127.0.0.1:34256_ct_em%2Fd ] o.a.s.h.a.CollectionsHandler Invoked
Collection Action :addreplica with params
node=127.0.0.1:44197_ct_em%252Fd&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2418302 INFO
(OverseerCollectionConfigSetProcessor-75998577446617092-127.0.0.1:34673_ct_em%2Fd-n_0000000000)
[n:127.0.0.1:34673_ct_em%2Fd ] 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> 2418303 INFO
(OverseerThreadFactory-6873-thread-3-processing-n:127.0.0.1:34673_ct_em%2Fd)
[n:127.0.0.1:34673_ct_em%2Fd c:collection1 s:shard1 ]
o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:38285_ct_em%2Fd for
creating new replica of shard shard1 for collection collection1
[junit4] 2> 2418305 INFO
(OverseerThreadFactory-6873-thread-3-processing-n:127.0.0.1:34673_ct_em%2Fd)
[n:127.0.0.1:34673_ct_em%2Fd c:collection1 s:shard1 ]
o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 2418309 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd x:collection1_shard1_replica_n1 ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n1&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2419321 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion:
8.5.0
[junit4] 2> 2419335 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema
[collection1_shard1_replica_n1] Schema name=test
[junit4] 2> 2419404 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.6
with uniqueid field id
[junit4] 2> 2419419 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore
'collection1_shard1_replica_n1' using configuration from collection
collection1, trusted=true
[junit4] 2> 2419419 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard1.replica_n1' (registry
'solr.core.collection1.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2419419 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore
[[collection1_shard1_replica_n1] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-1-001/cores/collection1_shard1_replica_n1],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-1-001/cores/collection1_shard1_replica_n1/data/]
[junit4] 2> 2419422 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 2419432 WARN (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_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> 2419474 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2419474 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog:
dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 2419475 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if
uncommitted for 15000ms;
[junit4] 2> 2419475 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 2419476 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=32, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=25.9482421875,
floorSegmentMB=1.9375, forceMergeDeletesPctAllowed=1.730828506207206,
segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5851214367745134, deletesPctAllowed=32.366511292856444
[junit4] 2> 2419477 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening
[Searcher@6ef18982[collection1_shard1_replica_n1] main]
[junit4] 2> 2419478 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2419478 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2419479 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be
reserved for 10000ms.
[junit4] 2> 2419479 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version
in index or recent updates, using new clock 1654440317006381056
[junit4] 2> 2419482 INFO
(searcherExecutor-6910-thread-1-processing-n:127.0.0.1:38285_ct_em%2Fd
x:collection1_shard1_replica_n1 c:collection1 s:shard1)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore
[collection1_shard1_replica_n1] Registered new searcher
Searcher@6ef18982[collection1_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2419484 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of
terms at /collections/collection1/terms/shard1 to Terms{values={core_node2=0},
version=0}
[junit4] 2> 2419485 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make
sure parent is created /collections/collection1/leaders/shard1
[junit4] 2> 2419488 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough
replicas found to continue.
[junit4] 2> 2419488 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be
the new leader - try and sync
[junit4] 2> 2419488 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:38285/ct_em/d/collection1_shard1_replica_n1/
[junit4] 2> 2419488 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 2419488 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy
http://127.0.0.1:38285/ct_em/d/collection1_shard1_replica_n1/ has no replicas
[junit4] 2> 2419488 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase
Creating leader registration node
/collections/collection1/leaders/shard1/leader after winning as
/collections/collection1/leader_elect/shard1/election/75998577446617100-core_node2-n_0000000000
[junit4] 2> 2419490 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the
new leader: http://127.0.0.1:38285/ct_em/d/collection1_shard1_replica_n1/ shard1
[junit4] 2> 2419592 INFO (zkCallback-8020-thread-1) [ ]
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: [4])
[junit4] 2> 2419592 INFO (zkCallback-8020-thread-2) [ ]
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: [4])
[junit4] 2> 2419593 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 2419596 INFO (qtp1192584714-23136)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n1&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1287
[junit4] 2> 2419599 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 ] o.a.s.s.HttpSolrCall [admin]
webapp=null path=/admin/collections
params={node=127.0.0.1:38285_ct_em%252Fd&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
status=0 QTime=1300
[junit4] 2> 2419695 INFO (zkCallback-8020-thread-2) [ ]
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: [4])
[junit4] 2> 2419695 INFO (zkCallback-8020-thread-1) [ ]
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: [4])
[junit4] 2> 2419695 INFO (zkCallback-8020-thread-3) [ ]
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: [4])
[junit4] 2> 2420306 INFO
(OverseerCollectionConfigSetProcessor-75998577446617092-127.0.0.1:34673_ct_em%2Fd-n_0000000000)
[n:127.0.0.1:34673_ct_em%2Fd ] 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> 2420307 INFO
(OverseerThreadFactory-6873-thread-4-processing-n:127.0.0.1:34673_ct_em%2Fd)
[n:127.0.0.1:34673_ct_em%2Fd c:collection1 s:shard1 ]
o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:34256_ct_em%2Fd for
creating new replica of shard shard1 for collection collection1
[junit4] 2> 2420308 INFO
(OverseerThreadFactory-6873-thread-4-processing-n:127.0.0.1:34673_ct_em%2Fd)
[n:127.0.0.1:34673_ct_em%2Fd c:collection1 s:shard1 ]
o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 2420314 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd x:collection1_shard1_replica_n3 ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n3&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2420430 INFO (zkCallback-8020-thread-3) [ ]
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: [4])
[junit4] 2> 2420430 INFO (zkCallback-8020-thread-1) [ ]
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: [4])
[junit4] 2> 2420430 INFO (zkCallback-8020-thread-2) [ ]
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: [4])
[junit4] 2> 2421326 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.c.SolrConfig Using Lucene MatchVersion:
8.5.0
[junit4] 2> 2421340 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.s.IndexSchema
[collection1_shard1_replica_n3] Schema name=test
[junit4] 2> 2421411 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.s.IndexSchema Loaded schema test/1.6
with uniqueid field id
[junit4] 2> 2421425 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.c.CoreContainer Creating SolrCore
'collection1_shard1_replica_n3' using configuration from collection
collection1, trusted=true
[junit4] 2> 2421426 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard1.replica_n3' (registry
'solr.core.collection1.shard1.replica_n3') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@6d92ba91
[junit4] 2> 2421426 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.c.SolrCore
[[collection1_shard1_replica_n3] ] Opening new SolrCore at
[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-2-001/cores/collection1_shard1_replica_n3],
dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_69F495BA089935F5-001/shard-2-001/cores/collection1_shard1_replica_n3/data/]
[junit4] 2> 2421429 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.LogByteSizeMergePolicy:
[LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42,
maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807,
calibrateSizeByDeletes=false, maxMergeDocs=2147483647,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 2421439 WARN (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] 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> 2421483 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2421483 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.u.UpdateLog Initializing UpdateLog:
dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 2421485 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.u.CommitTracker Hard AutoCommit: if
uncommitted for 15000ms;
[junit4] 2> 2421485 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 2421486 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.u.RandomMergePolicy RandomMergePolicy
wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=32, maxMergeAtOnceExplicit=48, maxMergedSegmentMB=25.9482421875,
floorSegmentMB=1.9375, forceMergeDeletesPctAllowed=1.730828506207206,
segmentsPerTier=22.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5851214367745134, deletesPctAllowed=32.366511292856444
[junit4] 2> 2421486 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.s.SolrIndexSearcher Opening
[Searcher@717b309b[collection1_shard1_replica_n3] main]
[junit4] 2> 2421488 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2421488 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.r.ManagedResourceStorage Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2421488 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.h.ReplicationHandler Commits will be
reserved for 10000ms.
[junit4] 2> 2421488 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.u.UpdateLog Could not find max version
in index or recent updates, using new clock 1654440319112970240
[junit4] 2> 2421492 INFO
(searcherExecutor-6915-thread-1-processing-n:127.0.0.1:34256_ct_em%2Fd
x:collection1_shard1_replica_n3 c:collection1 s:shard1)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.c.SolrCore
[collection1_shard1_replica_n3] Registered new searcher
Searcher@717b309b[collection1_shard1_replica_n3]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2421494 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.c.ZkShardTerms Successful update of
terms at /collections/collection1/terms/shard1 to Terms{values={core_node2=0,
core_node4=0}, version=1}
[junit4] 2> 2421494 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.c.ShardLeaderElectionContextBase make
sure parent is created /collections/collection1/leaders/shard1
[junit4] 2> 2421497 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.c.ZkController Core needs to
recover:collection1_shard1_replica_n3
[junit4] 2> 2421497 INFO
(updateExecutor-8014-thread-1-processing-n:127.0.0.1:34256_ct_em%2Fd
x:collection1_shard1_replica_n3 c:collection1 s:shard1)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1 r:core_node4
x:collection1_shard1_replica_n3 ] o.a.s.u.DefaultSolrCoreState Running recovery
[junit4] 2> 2421498 INFO (qtp1719811240-23151)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1
x:collection1_shard1_replica_n3 ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n3&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1184
[junit4] 2> 2421506 INFO
(recoveryExecutor-8016-thread-1-processing-n:127.0.0.1:34256_ct_em%2Fd
x:collection1_shard1_replica_n3 c:collection1 s:shard1 r:core_node4)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1 r:core_node4
x:collection1_shard1_replica_n3 ] o.a.s.c.RecoveryStrategy Starting recovery
process. recoveringAfterStartup=true
[junit4] 2> 2421506 INFO
(recoveryExecutor-8016-thread-1-processing-n:127.0.0.1:34256_ct_em%2Fd
x:collection1_shard1_replica_n3 c:collection1 s:shard1 r:core_node4)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1 r:core_node4
x:collection1_shard1_replica_n3 ] o.a.s.c.RecoveryStrategy startupVersions is
empty
[junit4] 2> 2421508 INFO (qtp1192584714-23139)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica_n1 ] o.a.s.c.S.Request
[collection1_shard1_replica_n1] webapp=/ct_em/d path=/admin/ping
params={wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 2> 2421508 INFO (qtp1192584714-23139)
[n:127.0.0.1:38285_ct_em%2Fd c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica_n1 ] o.a.s.c.S.Request
[collection1_shard1_replica_n1] webapp=/ct_em/d path=/admin/ping
params={wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 2421508 INFO
(recoveryExecutor-8016-thread-1-processing-n:127.0.0.1:34256_ct_em%2Fd
x:collection1_shard1_replica_n3 c:collection1 s:shard1 r:core_node4)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1 r:core_node4
x:collection1_shard1_replica_n3 ] o.a.s.c.RecoveryStrategy Begin buffering
updates. core=[collection1_shard1_replica_n3]
[junit4] 2> 2421508 INFO
(recoveryExecutor-8016-thread-1-processing-n:127.0.0.1:34256_ct_em%2Fd
x:collection1_shard1_replica_n3 c:collection1 s:shard1 r:core_node4)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1 r:core_node4
x:collection1_shard1_replica_n3 ] o.a.s.u.UpdateLog Starting to buffer updates.
FSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 2421508 INFO
(recoveryExecutor-8016-thread-1-processing-n:127.0.0.1:34256_ct_em%2Fd
x:collection1_shard1_replica_n3 c:collection1 s:shard1 r:core_node4)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1 r:core_node4
x:collection1_shard1_replica_n3 ] o.a.s.c.RecoveryStrategy Publishing state of
core [collection1_shard1_replica_n3] as recovering, leader is
[http://127.0.0.1:38285/ct_em/d/collection1_shard1_replica_n1/] and I am
[http://127.0.0.1:34256/ct_em/d/collection1_shard1_replica_n3/]
[junit4] 2> 2421514 INFO
(recoveryExecutor-8016-thread-1-processing-n:127.0.0.1:34256_ct_em%2Fd
x:collection1_shard1_replica_n3 c:collection1 s:shard1 r:core_node4)
[n:127.0.0.1:34256_ct_em%2Fd c:collection1 s:shard1 r:core_node4
x:collection1_shard1_
[...truncated too long message...]
oolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 99) Thread[id=23409, name=updateExecutor-8027-thread-2,
state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[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.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] 2> at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
[junit4] 2> at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1073)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 100) Thread[id=23215, name=zkCallback-8038-thread-1,
state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[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.SynchronousQueue$TransferStack.awaitFulfill(SynchronousQueue.java:460)
[junit4] 2> at
java.util.concurrent.SynchronousQueue$TransferStack.transfer(SynchronousQueue.java:362)
[junit4] 2> at
java.util.concurrent.SynchronousQueue.poll(SynchronousQueue.java:941)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1073)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 101) Thread[id=23394,
name=zkConnectionManagerCallback-8079-thread-1, state=WAITING,
group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 102) Thread[id=23365, name=h2sc-7975-thread-9,
state=WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.take(BlockingArrayQueue.java:342)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1074)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1134)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 103) Thread[id=23395,
name=TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[69F495BA089935F5]-SendThread(127.0.0.1:44024),
state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:369)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1137)
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84):
{rnd_b=PostingsFormat(name=MockRandom), a_t=PostingsFormat(name=Asserting),
_root_=PostingsFormat(name=Direct), id=PostingsFormat(name=MockRandom)},
docValues:{rnd_b=DocValuesFormat(name=Lucene80),
_version_=DocValuesFormat(name=Direct), a_t=DocValuesFormat(name=Asserting),
_root_=DocValuesFormat(name=Direct), a_i=DocValuesFormat(name=Lucene80),
id=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=651,
maxMBSortInHeap=5.6051039831959155,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@6f76a03d),
locale=pt, timezone=Asia/Famagusta
[junit4] 2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation
1.8.0_191 (64-bit)/cpus=4,threads=116,free=178510304,total=497549312
[junit4] 2> NOTE: All tests run in this JVM: [TestDFRSimilarityFactory,
MoveReplicaHDFSTest, SolrJmxReporterCloudTest, TestSimDistributedQueue,
CloneFieldUpdateProcessorFactoryTest, DistribJoinFromCollectionTest,
SignatureUpdateProcessorFactoryTest, CollectionsAPIDistributedZkTest,
HdfsCollectionsAPIDistributedZkTest, TestImplicitCoreProperties,
ProtectedTermFilterFactoryTest, DistanceUnitsTest, TestSimClusterStateProvider,
DistributedFacetPivotWhiteBoxTest, DistributedSuggestComponentTest,
TestSolrCachePerf, RuleEngineTest, TestLeaderElectionZkExpiry,
TestRawTransformer, V2StandaloneTest, TestDynamicFieldResource,
OutOfBoxZkACLAndCredentialsProvidersTest, TestNumericTerms64, SparseHLLTest,
RecoveryAfterSoftCommitTest, SynonymTokenizerTest, TestNRTOpen,
DistributedFacetPivotLongTailTest, StatsComponentTest,
AnalysisErrorHandlingTest, TestDocTermOrdsUninvertLimit,
CdcrReplicationHandlerTest, HLLSerializationTest,
AtomicUpdateRemovalJavabinTest, DistributedUpdateProcessorTest,
TestAuthorizationFramework, LegacyCloudClusterPropTest, MetricTriggerTest,
TestDistributedMap, XmlInterpolationTest, BitVectorTest, TransactionLogTest,
TestNumericTokenStream, MoreLikeThisHandlerTest, TestSolrConfigHandler,
TestBM25SimilarityFactory, DirectSolrConnectionTest, StatsReloadRaceTest,
TestMaxTokenLenTokenizer, BadIndexSchemaTest, TestExceedMaxTermLength,
TestReloadAndDeleteDocs, QueryParsingTest, TokenizerChainTest, PolyFieldTest,
MultiDestinationAuditLoggerTest, ZkSolrClientTest, TestCustomSort,
OrderedExecutorTest, TestSizeLimitedDistributedMap,
WrapperMergePolicyFactoryTest, ShowFileRequestHandlerTest,
TestDistributedStatsComponentCardinality, TestCloudRecovery2,
SubstringBytesRefFilterTest, SignificantTermsQParserPluginTest,
BasicDistributedZkTest, BasicAuthOnSingleNodeTest,
RoutingToNodesWithPropertiesTest, TestSmileRequest, TestDistribPackageStore,
OverseerModifyCollectionTest, ShardRoutingCustomTest, OutputWriterTest,
ConnectionReuseTest, TestFieldTypeCollectionResource,
TestSimGenericDistributedQueue, HdfsRestartWhileUpdatingTest,
TestStressInPlaceUpdates, TestRecoveryHdfs, InfoHandlerTest,
CoreMergeIndexesAdminHandlerTest, UpdateRequestProcessorFactoryTest,
SolrPluginUtilsTest, JavabinLoaderTest, TestCollationFieldDocValues,
TestConfigSets, TestInitQParser, TestJmxIntegration, GraphQueryTest,
MBeansHandlerTest, IndexSchemaRuntimeFieldTest, ClusterStateTest,
VersionInfoTest, CdcrBidirectionalTest, TestRandomRequestDistribution,
TestStressThreadBackup, TermVectorComponentDistributedTest,
NodeLostTriggerIntegrationTest, TestManagedSchemaAPI, TestBadConfig,
TestBlendedInfixSuggestions, ZkFailoverTest, ScheduledTriggerTest,
TestSSLRandomization, TestDistributedGrouping, OverseerTest,
SpellingQueryConverterTest, TestReqParamsAPI, TestCryptoKeys,
TestDocumentBuilder, CollectionReloadTest, TestManagedSynonymFilterFactory,
TestXmlQParser, TestFilteredDocIdSet, AliasIntegrationTest,
TestOverriddenPrefixQueryForCustomFieldType,
ClassificationUpdateProcessorFactoryTest, TestGeoJSONResponseWriter,
AdminHandlersProxyTest, NestedAtomicUpdateTest, CreateRoutedAliasTest,
TestSolrCloudWithHadoopAuthPlugin, HdfsAutoAddReplicasIntegrationTest,
TemplateUpdateProcessorTest, TestBinaryResponseWriter, TestSurroundQueryParser,
SplitByPrefixTest, TestPseudoReturnFields, CircularListTest,
TestComplexPhraseLeadingWildcard, SuggesterFSTTest, TriggerEventQueueTest,
TestExclusionRuleCollectionAccess, MigrateRouteKeyTest, TestJsonRequest,
HdfsTlogReplayBufferedWhileIndexingTest,
VMParamsZkACLAndCredentialsProvidersTest, AuditLoggerIntegrationTest,
TestPartialUpdateDeduplication, BlockCacheTest,
TestLMJelinekMercerSimilarityFactory, SearchHandlerTest,
BlobRepositoryCloudTest, AnalysisAfterCoreReloadTest, BasicFunctionalityTest,
ConvertedLegacyTest, CursorPagingTest, DisMaxRequestHandlerTest,
DistributedIntervalFacetingTest, SampleTest, SolrInfoBeanTest,
SolrTestCaseJ4Test, TestGroupingSearch, TestHighlightDedupGrouping, TestJoin,
TestRandomDVFaceting, TestSimpleTrackingShardHandler, TestLuceneMatchVersion,
TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors,
BasicZkTest, ChaosMonkeyNothingIsSafeTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=ChaosMonkeyNothingIsSafeTest -Dtests.seed=69F495BA089935F5
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=pt
-Dtests.timezone=Asia/Famagusta -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J2 | ChaosMonkeyNothingIsSafeTest (suite) <<<
[junit4] > Throwable #1: java.lang.Exception: Suite timeout exceeded (>=
7200000 msec).
[junit4] > at
__randomizedtesting.SeedInfo.seed([69F495BA089935F5]:0)
[junit4] Completed [891/891 (1!)] on J2 in 7213.55s, 1 test, 2 errors <<<
FAILURES!
[...truncated 52946 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
