You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2020/01/26 10:57:36 UTC
[JENKINS-Experimental-GC] Lucene-Solr-8.x-Linux (64bit/jdk-13.0.2)
- Build # 1911 - Failure!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/1911/
Java: 64bit/jdk-13.0.2 -XX:-UseCompressedOops -XX:+UnlockExperimentalVMOptions -XX:+UseShenandoahGC -XX:ShenandoahCodeRootsStyle=1
1 tests failed.
FAILED: org.apache.solr.schema.TestBulkSchemaConcurrent.test
Error Message:
[[], [], [dynamic field *_lol3 not created, field a3 not created, new type mystr3 not created, CopyField source=a3,dest=hello_lol3 not created], [], [CopyField source=a4,dest=hello_lol4 not created, dynamic field *_lol4 not created, field a4 not created, new type mystr4 not created]]
Stack Trace:
java.lang.AssertionError: [[], [], [dynamic field *_lol3 not created, field a3 not created, new type mystr3 not created, CopyField source=a3,dest=hello_lol3 not created], [], [CopyField source=a4,dest=hello_lol4 not created, dynamic field *_lol4 not created, field a4 not created, new type mystr4 not created]]
at __randomizedtesting.SeedInfo.seed([AA15F84E34491286:2241C7949AB57F7E]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.apache.solr.schema.TestBulkSchemaConcurrent.test(TestBulkSchemaConcurrent.java:94)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:567)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:830)
Build Log:
[...truncated 14340 lines...]
[junit4] JVM J5: stdout was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/temp/junit4-J5-20200126_102328_1507092075643679870040.sysout
[junit4] >>> JVM J5 emitted unexpected output (verbatim) ----
[junit4] #
[junit4] # A fatal error has been detected by the Java Runtime Environment:
[junit4] #
[junit4] # SIGSEGV (0xb) at pc=0x00007fee3c795fd9, pid=12838, tid=7775
[junit4] #
[junit4] # JRE version: OpenJDK Runtime Environment (13.0.2+8) (build 13.0.2+8)
[junit4] # Java VM: OpenJDK 64-Bit Server VM (13.0.2+8, mixed mode, tiered, shenandoah gc, linux-amd64)
[junit4] # Problematic frame:
[junit4] # V [libjvm.so+0xcd3fd9] PhaseIterGVN::transform_old(Node*)+0x159
[junit4] #
[junit4] # No core dump will be written. Core dumps have been disabled. To enable core dumping, try "ulimit -c unlimited" before starting Java again
[junit4] #
[junit4] # An error report file with more information is saved as:
[junit4] # /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J5/hs_err_pid12838.log
[junit4] [thread 7762 also had an error]
[junit4]
[junit4] ------ Timeout during error reporting after 120 s. ------
[junit4] # [ timer expired, abort... ]
[junit4] <<< JVM J5: EOF ----
[...truncated 966 lines...]
[junit4] JVM J4: stdout was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/temp/junit4-J4-20200126_102328_15018357133902570273199.sysout
[junit4] >>> JVM J4 emitted unexpected output (verbatim) ----
[junit4] #
[junit4] # A fatal error has been detected by the Java Runtime Environment:
[junit4] #
[junit4] # SIGSEGV (0xb) at pc=0x00007faca4c2cfd9, pid=12862, tid=12915
[junit4] #
[junit4] # JRE version: OpenJDK Runtime Environment (13.0.2+8) (build 13.0.2+8)
[junit4] # Java VM: OpenJDK 64-Bit Server VM (13.0.2+8, mixed mode, tiered, shenandoah gc, linux-amd64)
[junit4] # Problematic frame:
[junit4] # V [libjvm.so+0xcd3fd9] PhaseIterGVN::transform_old(Node*)+0x159
[junit4] #
[junit4] # No core dump will be written. Core dumps have been disabled. To enable core dumping, try "ulimit -c unlimited" before starting Java again
[junit4] #
[junit4] # An error report file with more information is saved as:
[junit4] # /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J4/hs_err_pid12862.log
[junit4] [thread 22898 also had an error]
[junit4]
[junit4] ------ Timeout during error reporting after 120 s. ------
[junit4] # [ timer expired, abort... ]
[junit4] <<< JVM J4: EOF ----
[...truncated 1181 lines...]
[junit4] Suite: org.apache.solr.schema.TestBulkSchemaConcurrent
[junit4] 2> 1322529 INFO (SUITE-TestBulkSchemaConcurrent-seed#[AA15F84E34491286]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1322530 INFO (SUITE-TestBulkSchemaConcurrent-seed#[AA15F84E34491286]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/data-dir-213-001
[junit4] 2> 1322530 WARN (SUITE-TestBulkSchemaConcurrent-seed#[AA15F84E34491286]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=52 numCloses=52
[junit4] 2> 1322530 INFO (SUITE-TestBulkSchemaConcurrent-seed#[AA15F84E34491286]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1322531 INFO (SUITE-TestBulkSchemaConcurrent-seed#[AA15F84E34491286]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 1322531 INFO (SUITE-TestBulkSchemaConcurrent-seed#[AA15F84E34491286]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 1322537 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1322539 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1322539 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1322639 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer start zk server on port:42825
[junit4] 2> 1322639 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:42825
[junit4] 2> 1322639 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:42825
[junit4] 2> 1322639 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 42825
[junit4] 2> 1322641 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1322650 INFO (zkConnectionManagerCallback-10523-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1322650 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1322658 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1322665 INFO (zkConnectionManagerCallback-10525-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1322666 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1322667 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-managed-schema.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 1322669 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 1322670 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1322678 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 1322679 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 1322680 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 1322681 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 1322681 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1322682 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1322683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 1322683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 1322684 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1322686 INFO (zkConnectionManagerCallback-10529-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1322686 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1322810 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
[junit4] 2> 1322960 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1322960 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1322960 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1322960 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 1323023 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1323023 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1323023 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1323024 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@11046d31{/,null,AVAILABLE}
[junit4] 2> 1323043 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@23687951{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:43063}
[junit4] 2> 1323043 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.s.Server Started @1323064ms
[junit4] 2> 1323043 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/tempDir-001/control/data, hostPort=43063, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/control-001/cores, replicaType=NRT}
[junit4] 2> 1323043 ERROR (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1323043 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1323044 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.5.0
[junit4] 2> 1323044 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1323044 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1323044 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T10:45:31.244058Z
[junit4] 2> 1323062 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1323068 INFO (zkConnectionManagerCallback-10531-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1323068 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1323169 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1323169 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/control-001/solr.xml
[junit4] 2> 1323172 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1323172 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1323173 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1323222 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1323224 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@b8951a5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1323224 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@b8951a5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1323227 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4cc7d44d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1323227 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4cc7d44d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1323229 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42825/solr
[junit4] 2> 1323229 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1323230 INFO (zkConnectionManagerCallback-10538-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1323230 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1323340 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1323341 INFO (zkConnectionManagerCallback-10540-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1323341 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1323377 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:43063_
[junit4] 2> 1323377 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.c.Overseer Overseer (id=72077179031322629-127.0.0.1:43063_-n_0000000000) starting
[junit4] 2> 1323380 INFO (OverseerStateUpdate-72077179031322629-127.0.0.1:43063_-n_0000000000) [n:127.0.0.1:43063_ ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:43063_
[junit4] 2> 1323381 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43063_
[junit4] 2> 1323383 INFO (OverseerStateUpdate-72077179031322629-127.0.0.1:43063_-n_0000000000) [n:127.0.0.1:43063_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1323405 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1323415 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] 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> 1323449 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1323467 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1323474 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1323474 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1323475 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [n:127.0.0.1:43063_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/control-001/cores
[junit4] 2> 1323486 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1323487 INFO (zkConnectionManagerCallback-10549-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1323487 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1323488 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1323488 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42825/solr ready
[junit4] 2> 1323500 INFO (qtp1244034358-34360) [n:127.0.0.1:43063_ ] 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:43063_&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1323502 INFO (OverseerThreadFactory-10488-thread-1-processing-n:127.0.0.1:43063_) [n:127.0.0.1:43063_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 1323619 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1323619 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ x:control_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1324628 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.0
[junit4] 2> 1324635 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 1324640 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1324866 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1324915 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/conf1/managed-schema
[junit4] 2> 1324923 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/conf1/schema.xml to /configs/conf1/schema.xml.bak
[junit4] 2> 1324926 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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 configset conf1, trusted=true
[junit4] 2> 1324927 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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@7218fba5
[junit4] 2> 1324927 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 1324938 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11533978697861871]
[junit4] 2> 1324940 WARN (qtp1244034358-34362) [n:127.0.0.1:43063_ 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, registerPath=/solr,/v2, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1324978 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1324978 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1324980 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1324980 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1324981 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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=45, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=92.1796875, floorSegmentMB=1.73046875, forceMergeDeletesPctAllowed=21.907132331717566, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11062610147245994, deletesPctAllowed=42.398387763003235
[junit4] 2> 1324981 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@13db6710[control_collection_shard1_replica_n1] main]
[junit4] 2> 1324983 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1324983 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1324983 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
[junit4] 2> 1324984 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 1324984 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1324984 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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 1656787339243945984
[junit4] 2> 1324986 INFO (searcherExecutor-10493-thread-1-processing-n:127.0.0.1:43063_ x:control_collection_shard1_replica_n1 c:control_collection s:shard1) [n:127.0.0.1:43063_ 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@13db6710[control_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1324988 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1324988 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1324990 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1324990 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1324990 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:43063/control_collection_shard1_replica_n1/
[junit4] 2> 1324990 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1324990 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy https://127.0.0.1:43063/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 1324990 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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/72077179031322629-core_node2-n_0000000000
[junit4] 2> 1324991 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:43063/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 1325092 INFO (zkCallback-10539-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> 1325093 INFO (zkCallback-10539-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> 1325093 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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> 1325095 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ 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=1476
[junit4] 2> 1325096 INFO (qtp1244034358-34360) [n:127.0.0.1:43063_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1325206 INFO (zkCallback-10539-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> 1325206 INFO (zkCallback-10539-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> 1325206 INFO (zkCallback-10539-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> 1325206 INFO (qtp1244034358-34360) [n:127.0.0.1:43063_ ] 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:43063_&wt=javabin&version=2} status=0 QTime=1706
[junit4] 2> 1325207 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in collection: control_collection
[junit4] 2> 1325332 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1325333 INFO (zkConnectionManagerCallback-10555-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1325333 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1325334 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1325334 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42825/solr ready
[junit4] 2> 1325334 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 1325342 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1325344 INFO (OverseerCollectionConfigSetProcessor-72077179031322629-127.0.0.1:43063_-n_0000000000) [n:127.0.0.1:43063_ ] 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> 1325344 INFO (OverseerThreadFactory-10488-thread-2-processing-n:127.0.0.1:43063_) [n:127.0.0.1:43063_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 1325545 WARN (OverseerThreadFactory-10488-thread-2-processing-n:127.0.0.1:43063_) [n:127.0.0.1:43063_ ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
[junit4] 2> 1325550 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 1325551 INFO (qtp1244034358-34362) [n:127.0.0.1:43063_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2} status=0 QTime=209
[junit4] 2> 1325552 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 1325552 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1325552 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 1325552 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1325552 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 1325552 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 1325552 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=4
[junit4] 2> 1325652 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-1-001 of type NRT for shard2
[junit4] 2> 1325662 WARN (closeThreadPool-10556-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1325662 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1325663 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1325663 INFO (closeThreadPool-10556-thread-1) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 1325735 INFO (closeThreadPool-10556-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1325735 INFO (closeThreadPool-10556-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1325735 INFO (closeThreadPool-10556-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1325736 INFO (closeThreadPool-10556-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@6e75be49{/,null,AVAILABLE}
[junit4] 2> 1325761 INFO (closeThreadPool-10556-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@33229f2c{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:44177}
[junit4] 2> 1325761 INFO (closeThreadPool-10556-thread-1) [ ] o.e.j.s.Server Started @1325782ms
[junit4] 2> 1325761 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/tempDir-001/jetty1, hostPort=44177, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-1-001/cores}
[junit4] 2> 1325761 ERROR (closeThreadPool-10556-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1325761 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1325761 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.5.0
[junit4] 2> 1325761 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1325761 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1325761 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T10:45:33.961601Z
[junit4] 2> 1325790 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1325790 INFO (zkConnectionManagerCallback-10558-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1325791 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1325870 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-2-001 of type NRT for shard1
[junit4] 2> 1325872 WARN (closeThreadPool-10556-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1325872 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1325872 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1325872 INFO (closeThreadPool-10556-thread-2) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 1325894 INFO (closeThreadPool-10556-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1325894 INFO (closeThreadPool-10556-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1325894 INFO (closeThreadPool-10556-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1325894 INFO (closeThreadPool-10556-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@42ac2679{/,null,AVAILABLE}
[junit4] 2> 1325905 INFO (closeThreadPool-10556-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7db0fbc8{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:38577}
[junit4] 2> 1325906 INFO (closeThreadPool-10556-thread-2) [ ] o.e.j.s.Server Started @1325926ms
[junit4] 2> 1325906 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/tempDir-001/jetty2, hostPort=38577, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-2-001/cores}
[junit4] 2> 1325906 ERROR (closeThreadPool-10556-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1325906 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1325906 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.5.0
[junit4] 2> 1325906 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1325906 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1325906 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T10:45:34.106425Z
[junit4] 2> 1325906 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1325906 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-1-001/solr.xml
[junit4] 2> 1325909 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1325909 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1325910 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1325912 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1325912 INFO (zkConnectionManagerCallback-10560-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1325912 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1325964 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-3-001 of type NRT for shard2
[junit4] 2> 1325966 WARN (closeThreadPool-10556-thread-3) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1325966 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1325966 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1325966 INFO (closeThreadPool-10556-thread-3) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 1325968 INFO (closeThreadPool-10556-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1325968 INFO (closeThreadPool-10556-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1325968 INFO (closeThreadPool-10556-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1325968 INFO (closeThreadPool-10556-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@196c5299{/,null,AVAILABLE}
[junit4] 2> 1325970 INFO (closeThreadPool-10556-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@e538901{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:39699}
[junit4] 2> 1325970 INFO (closeThreadPool-10556-thread-3) [ ] o.e.j.s.Server Started @1325991ms
[junit4] 2> 1325970 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/tempDir-001/jetty3, hostPort=39699, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-3-001/cores}
[junit4] 2> 1325970 ERROR (closeThreadPool-10556-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1325970 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1325970 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.5.0
[junit4] 2> 1325970 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1325970 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1325970 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T10:45:34.170970Z
[junit4] 2> 1325971 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1325972 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1325973 WARN (closeThreadPool-10556-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7a57522c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1325973 WARN (closeThreadPool-10556-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7a57522c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1325978 INFO (zkConnectionManagerCallback-10563-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1325979 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1325981 WARN (closeThreadPool-10556-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7f4c32c0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1325981 WARN (closeThreadPool-10556-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7f4c32c0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1325983 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42825/solr
[junit4] 2> 1325985 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1325985 INFO (zkConnectionManagerCallback-10569-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1325985 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1326026 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1326026 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-2-001/solr.xml
[junit4] 2> 1326028 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1326028 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1326038 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1326126 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1326126 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-3-001/solr.xml
[junit4] 2> 1326127 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[AA15F84E34491286]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-4-001 of type NRT for shard1
[junit4] 2> 1326129 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1326129 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1326131 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1326145 WARN (closeThreadPool-10556-thread-4) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 1326145 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 1326145 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1326145 INFO (closeThreadPool-10556-thread-4) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 13.0.2+8
[junit4] 2> 1326186 INFO (closeThreadPool-10556-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1326186 INFO (closeThreadPool-10556-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1326186 INFO (closeThreadPool-10556-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1326190 INFO (closeThreadPool-10556-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@276fde36{/,null,AVAILABLE}
[junit4] 2> 1326191 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1326193 WARN (closeThreadPool-10556-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@17061bbe[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326193 WARN (closeThreadPool-10556-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@17061bbe[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326228 WARN (closeThreadPool-10556-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@581645ec[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326228 WARN (closeThreadPool-10556-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@581645ec[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326229 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42825/solr
[junit4] 2> 1326230 INFO (closeThreadPool-10556-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2069a466{ssl,[ssl, alpn, http/1.1, h2]}{127.0.0.1:43983}
[junit4] 2> 1326230 INFO (closeThreadPool-10556-thread-4) [ ] o.e.j.s.Server Started @1326250ms
[junit4] 2> 1326230 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/tempDir-001/jetty4, hostPort=43983, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-4-001/cores}
[junit4] 2> 1326230 ERROR (closeThreadPool-10556-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1326230 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1326230 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.5.0
[junit4] 2> 1326230 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1326230 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1326230 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T10:45:34.430336Z
[junit4] 2> 1326250 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1326251 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1326251 INFO (zkConnectionManagerCallback-10581-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1326251 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1326253 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1326254 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1326254 WARN (closeThreadPool-10556-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@28bdadb4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326254 WARN (closeThreadPool-10556-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@28bdadb4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326256 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1326256 INFO (zkConnectionManagerCallback-10579-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1326256 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1326256 INFO (zkConnectionManagerCallback-10577-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1326256 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1326256 WARN (closeThreadPool-10556-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@437419f6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326257 WARN (closeThreadPool-10556-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@437419f6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326257 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.c.ZkController Publish node=127.0.0.1:44177_ as DOWN
[junit4] 2> 1326258 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42825/solr
[junit4] 2> 1326266 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1326266 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1326266 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44177_
[junit4] 2> 1326267 INFO (zkCallback-10539-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1326267 INFO (zkCallback-10554-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1326269 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1326269 WARN (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] 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> 1326270 INFO (zkConnectionManagerCallback-10589-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1326270 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1326274 INFO (zkCallback-10580-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1326280 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1326292 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326297 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326297 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326298 INFO (closeThreadPool-10556-thread-1) [n:127.0.0.1:44177_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-1-001/cores
[junit4] 2> 1326313 INFO (closeThreadPool-10556-thread-1) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:44177_
[junit4] 2> 1326365 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1326365 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-4-001/solr.xml
[junit4] 2> 1326368 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1326368 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1326369 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1326467 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1326467 INFO (zkConnectionManagerCallback-10594-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1326467 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1326469 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1326471 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.c.ZkController Publish node=127.0.0.1:39699_ as DOWN
[junit4] 2> 1326472 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1326472 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39699_
[junit4] 2> 1326473 INFO (zkCallback-10539-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1326473 INFO (zkCallback-10580-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1326473 INFO (zkCallback-10554-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1326473 INFO (zkCallback-10593-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1326474 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1326474 WARN (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] 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> 1326484 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1326498 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326504 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326504 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326505 INFO (closeThreadPool-10556-thread-3) [n:127.0.0.1:39699_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-3-001/cores
[junit4] 2> 1326533 INFO (closeThreadPool-10556-thread-3) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:39699_
[junit4] 2> 1326566 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1326568 INFO (zkConnectionManagerCallback-10600-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1326568 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1326571 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1326575 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.c.ZkController Publish node=127.0.0.1:38577_ as DOWN
[junit4] 2> 1326576 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1326576 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38577_
[junit4] 2> 1326581 INFO (zkCallback-10580-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1326581 INFO (zkCallback-10593-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1326582 INFO (zkCallback-10554-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1326582 INFO (zkCallback-10539-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1326582 INFO (zkCallback-10599-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1326583 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1326583 WARN (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] 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> 1326594 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1326606 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326611 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326611 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326612 INFO (closeThreadPool-10556-thread-2) [n:127.0.0.1:38577_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-2-001/cores
[junit4] 2> 1326637 INFO (closeThreadPool-10556-thread-2) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:38577_
[junit4] 2> 1326761 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1326770 WARN (closeThreadPool-10556-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1d591bc6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326770 WARN (closeThreadPool-10556-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1d591bc6[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326785 WARN (closeThreadPool-10556-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1ff46c4f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326785 WARN (closeThreadPool-10556-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1ff46c4f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1326787 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42825/solr
[junit4] 2> 1326798 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1326802 INFO (zkConnectionManagerCallback-10610-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1326802 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1326905 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1326909 INFO (zkConnectionManagerCallback-10612-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 1326909 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1326913 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1326915 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.c.ZkController Publish node=127.0.0.1:43983_ as DOWN
[junit4] 2> 1326915 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1326915 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43983_
[junit4] 2> 1326916 INFO (zkCallback-10580-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1326916 INFO (zkCallback-10599-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1326916 INFO (zkCallback-10554-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1326916 INFO (zkCallback-10593-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1326916 INFO (zkCallback-10539-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1326916 INFO (zkCallback-10611-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1326917 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 1326918 WARN (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] 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> 1326929 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1326943 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326952 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326952 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1326953 INFO (closeThreadPool-10556-thread-4) [n:127.0.0.1:43983_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-4-001/cores
[junit4] 2> 1326994 INFO (closeThreadPool-10556-thread-4) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:43983_
[junit4] 2> 1327012 INFO (qtp370254190-34518) [n:127.0.0.1:38577_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:39699_&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1327015 INFO (qtp370254190-34516) [n:127.0.0.1:38577_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:43983_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1327015 INFO (qtp370254190-34512) [n:127.0.0.1:38577_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:38577_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1327024 INFO (OverseerCollectionConfigSetProcessor-72077179031322629-127.0.0.1:43063_-n_0000000000) [n:127.0.0.1:43063_ ] 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> 1327024 INFO (OverseerThreadFactory-10488-thread-3-processing-n:127.0.0.1:43063_) [n:127.0.0.1:43063_ c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:39699_ for creating new replica of shard shard2 for collection collection1
[junit4] 2> 1327026 INFO (OverseerThreadFactory-10488-thread-3-processing-n:127.0.0.1:43063_) [n:127.0.0.1:43063_ c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 1327026 INFO (qtp370254190-34514) [n:127.0.0.1:38577_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:44177_&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1327030 INFO (OverseerThreadFactory-10488-thread-4-processing-n:127.0.0.1:43063_) [n:127.0.0.1:43063_ c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:43983_ for creating new replica of shard shard1 for collection collection1
[junit4] 2> 1327034 INFO (OverseerThreadFactory-10488-thread-4-processing-n:127.0.0.1:43063_) [n:127.0.0.1:43063_ c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 1327059 INFO (qtp1243599737-34524) [n:127.0.0.1:39699_ x:collection1_shard2_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n1&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1327068 INFO (qtp1715081707-34531) [n:127.0.0.1:43983_ x:collection1_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n2&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1328070 INFO (qtp1243599737-34524) [n:127.0.0.1:39699_ c:collection1 s:shard2 x:collection1_shard2_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.0
[junit4] 2> 1328077 INFO (qtp1715081707-34531) [n:127.0.0.1:43983_ c:collection1 s:shard1 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.0
[junit4] 2> 1328087 INFO (qtp1243599737-34524) [n:127.0.0.1:39699_ c:collection1 s:shard2 x:collection1_shard2_replica_n1 ] o.a.s.s.IndexSchema [collection1_shard2_replica_n1] Schema name=test
[junit4] 2> 1328093 INFO (qtp1715081707-34531) [n:127.0.0.1:43983_ c:collection1 s:shard1 x:collection1_shard1_replica_n2 ] o.a.s.s.IndexSchema [collection1_shard1_replica_n2] Schema name=test
[junit4] 2> 1328489 INFO (qtp1243599737-34524) [n:127.0.0.1:39699_ c:collection1 s:shard2 x:collection1_shard2_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1328500 INFO (qtp1243599737-34524) [n:127.0.0.1:39699_ c:collection1 s:shard2 x:collection1_shard2_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n1' using configuration from configset conf1, trusted=true
[junit4] 2> 1328501 INFO (qtp1243599737-34524) [n:127.0.0.1:39699_ c:collection1 s:shard2 x:collection1_shard2_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard2.replica_n1' (registry 'solr.core.collection1.shard2.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1328501 INFO (qtp1243599737-34524) [n:127.0.0.1:39699_ c:collection1 s:shard2 x:collection1_shard2_replica_n1 ] o.a.s.c.SolrCore [[collection1_shard2_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-3-001/cores/collection1_shard2_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_AA15F84E34491286-001/shard-3-001/cores/collection1_shard2_replica_n1/data/]
[junit4] 2> 1328503 INFO (qtp1243599737-34524) [n:127.0.0.1:39699_ c:collection1 s:shard2 x:collection1_shard2_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=48, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11533978697861871]
[junit4] 2> 1328507 INFO (qtp1715081707-34531) [n:127.0.0.1:43983_ c:collection1 s:shard1 x:collection1_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1328514 WARN (qtp1243599737-34524) [n:127.0.0.1:39699_ c:collection1 s:shard2 x:collection1_shard2_replica_n1 ] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, registerPath=/solr,/v2, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1328517 INFO (qtp1715081707-34531) [n:127.0.0.1:43983_ c:collection1 s:shard1 x:collection1_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n2' using configuration from configset conf1, trusted=true
[junit4] 2> 1328517 INFO (qtp1715081707-34531) [n:127.0.0.1:43983_ c:collection1 s:shard1 x:collection1_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard1.replica_n2' (registry 'solr.core.collection1.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7218fba5
[junit4] 2> 1328517 INFO (qtp1715081707-34531) [n:127.0.0.1:43983_ c:collection1 s:shard1 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrCore [[collection1_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/workspa
[...truncated too long message...]
jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/solrj/lib/netty-resolver-4.1.29.Final.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/solrj/lib/netty-transport-4.1.29.Final.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/solrj/lib/netty-transport-native-epoll-4.1.29.Final.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/solrj/lib/netty-transport-native-unix-common-4.1.29.Final.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/solrj/lib/slf4j-api-1.7.24.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/solrj/lib/stax2-api-3.1.4.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/solrj/lib/woodstox-core-asl-4.4.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/solrj/lib/zookeeper-3.5.5.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/solrj/lib/zookeeper-jute-3.5.5.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/http2-common-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/http2-hpack-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/http2-server-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/javax.servlet-api-3.1.0.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-alpn-java-server-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-alpn-server-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-continuation-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-deploy-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-http-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-io-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-jmx-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-rewrite-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-security-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-server-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-servlet-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-servlets-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-util-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-webapp-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/jetty-xml-9.4.24.v20191120.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/metrics-core-4.1.2.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/metrics-graphite-4.1.2.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/metrics-jetty9-4.1.2.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/metrics-jmx-4.1.2.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/server/lib/metrics-jvm-4.1.2.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/example/example-DIH/solr/db/lib/derby-10.9.1.0.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/example/example-DIH/solr/db/lib/hsqldb-2.4.0.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/core/classes/java:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/test-framework/lib/hamcrest-core-1.3.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/test-framework/lib/junit-4.12.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/test-framework/lib/randomizedtesting-runner-2.7.2.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/antlr4-runtime-4.5.1-1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/byte-buddy-1.9.3.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/commons-compress-1.19.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/commons-logging-1.1.3.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/commons-text-1.6.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/hadoop-common-3.2.0-tests.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/hadoop-hdfs-3.2.0-tests.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/hadoop-hdfs-3.2.0.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/hadoop-minicluster-3.2.0.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/hadoop-minikdc-3.2.0.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/jersey-core-1.19.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/jersey-server-1.19.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/jersey-servlet-1.19.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerb-admin-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerb-client-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerb-common-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerb-crypto-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerb-identity-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerb-server-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerb-simplekdc-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerby-config-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerby-kdc-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/kerby-util-1.0.1.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/mockito-core-2.23.4.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/netty-all-4.1.29.Final.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/objenesis-2.6.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/test-lib/opentracing-mock-0.33.0.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/icu/lucene-analyzers-icu-8.5.0-SNAPSHOT.jar:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-analysis-extras/classes/java:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/queryparser/classes/test:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/backward-codecs/classes/test:/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/contrib/analysis-extras/lib/icu4j-62.1.jar:/home/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.7.2.jar com.carrotsearch.ant.tasks.junit4.slave.SlaveMainSafe -eventsfile /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/temp/junit4-J5-20200126_102328_1502230850928641083216.events @/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/temp/junit4-J5-20200126_102328_1509549325391782350075.suites -stdin
[junit4] ERROR: JVM J5 ended with an exception: Forked process returned with error code: 134. Very likely a JVM crash. See process stdout at: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/temp/junit4-J5-20200126_102328_1507092075643679870040.sysout
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.executeSlave(JUnit4.java:1542)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4.access$000(JUnit4.java:123)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:997)
[junit4] at com.carrotsearch.ant.tasks.junit4.JUnit4$2.call(JUnit4.java:994)
[junit4] at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
[junit4] at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
[junit4] at java.base/java.lang.Thread.run(Thread.java:830)
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/build.xml:634: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/build.xml:578: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build.xml:231: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/common-build.xml:550: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/common-build.xml:1590: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/common-build.xml:1117: At least one slave process threw an exception, first: Forked process returned with error code: 134. Very likely a JVM crash. See process stdout at: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/temp/junit4-J4-20200126_102328_15018357133902570273199.sysout
Total time: 50 minutes 24 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[JENKINS] Lucene-Solr-8.x-Linux (64bit/jdk-11.0.6) - Build # 1917 -
Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Error processing tokens: Error while parsing action 'Text/ZeroOrMore/FirstOf/Token/DelimitedToken/DelimitedToken_Action3' at input position (line 79, pos 4):
)"}
^
java.lang.OutOfMemoryError: Java heap space
[JENKINS-EA] Lucene-Solr-8.x-Linux (64bit/jdk-14-ea+32) - Build #
1916 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Error processing tokens: Error while parsing action 'Text/ZeroOrMore/FirstOf/Token/DelimitedToken/DelimitedToken_Action3' at input position (line 79, pos 4):
)"}
^
java.lang.OutOfMemoryError: Java heap space
[JENKINS] Lucene-Solr-8.x-Linux (64bit/jdk1.8.0_201) - Build # 1915
- Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Error processing tokens: Error while parsing action 'Text/ZeroOrMore/FirstOf/Token/DelimitedToken/DelimitedToken_Action3' at input position (line 79, pos 4):
)"}
^
java.lang.OutOfMemoryError: Java heap space
[JENKINS] Lucene-Solr-8.x-Linux (64bit/jdk-12.0.2) - Build # 1914 -
Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Error processing tokens: Error while parsing action 'Text/ZeroOrMore/FirstOf/Token/DelimitedToken/DelimitedToken_Action3' at input position (line 79, pos 4):
)"}
^
java.lang.OutOfMemoryError: Java heap space
[JENKINS-Experimental-GC] Lucene-Solr-8.x-Linux (64bit/jdk-13.0.2)
- Build # 1913 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Error processing tokens: Error while parsing action 'Text/ZeroOrMore/FirstOf/Token/DelimitedToken/DelimitedToken_Action3' at input position (line 79, pos 4):
)"}
^
java.lang.OutOfMemoryError: Java heap space
[JENKINS] Lucene-Solr-8.x-Linux (32bit/jdk1.8.0_201) - Build # 1912
- Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/1912/
Java: 32bit/jdk1.8.0_201 -client -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.schema.TestBulkSchemaConcurrent.test
Error Message:
[[], [], [], [], [CopyField source=a4,dest=hello_lol4 not created, dynamic field *_lol4 not created, field a4 not created, new type mystr4 not created]]
Stack Trace:
java.lang.AssertionError: [[], [], [], [], [CopyField source=a4,dest=hello_lol4 not created, dynamic field *_lol4 not created, field a4 not created, new type mystr4 not created]]
at __randomizedtesting.SeedInfo.seed([48E052775EAF7F39:C0B46DADF05312C1]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.apache.solr.schema.TestBulkSchemaConcurrent.test(TestBulkSchemaConcurrent.java:94)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 15180 lines...]
[junit4] Suite: org.apache.solr.schema.TestBulkSchemaConcurrent
[junit4] 2> 644156 INFO (SUITE-TestBulkSchemaConcurrent-seed#[48E052775EAF7F39]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/data-dir-55-001
[junit4] 2> 644156 INFO (SUITE-TestBulkSchemaConcurrent-seed#[48E052775EAF7F39]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 644158 INFO (SUITE-TestBulkSchemaConcurrent-seed#[48E052775EAF7F39]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 644160 INFO (SUITE-TestBulkSchemaConcurrent-seed#[48E052775EAF7F39]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 644160 INFO (SUITE-TestBulkSchemaConcurrent-seed#[48E052775EAF7F39]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 644166 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 644166 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 644166 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 644266 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer start zk server on port:41219
[junit4] 2> 644266 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:41219
[junit4] 2> 644266 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:41219
[junit4] 2> 644266 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 41219
[junit4] 2> 644278 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 644292 INFO (zkConnectionManagerCallback-4701-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 644292 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 644310 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 644312 INFO (zkConnectionManagerCallback-4703-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 644312 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 644317 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-managed-schema.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 644339 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 644342 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 644361 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 644367 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 644369 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 644370 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 644395 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 644396 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 644396 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 644397 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 644399 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 644409 INFO (zkConnectionManagerCallback-4707-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 644410 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 644520 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
[junit4] 2> 644632 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 644632 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 644632 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 644632 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_201-b09
[junit4] 2> 644671 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 644671 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 644671 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 644676 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1140a30{/,null,AVAILABLE}
[junit4] 2> 644683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1525563{SSL,[ssl, http/1.1]}{127.0.0.1:44725}
[junit4] 2> 644683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.s.Server Started @644710ms
[junit4] 2> 644683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/tempDir-001/control/data, replicaType=NRT, hostContext=/, hostPort=44725, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/control-001/cores}
[junit4] 2> 644683 ERROR (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 644683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 644683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.5.0
[junit4] 2> 644683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 644683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 644683 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T12:55:32.250Z
[junit4] 2> 644686 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 644687 INFO (zkConnectionManagerCallback-4709-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 644687 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 644789 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 644789 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/control-001/solr.xml
[junit4] 2> 644796 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 644796 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 644798 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 645963 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 645964 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 645964 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@bac60a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 645965 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@bac60a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 645974 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 645975 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@406d63[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 645975 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@406d63[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 645977 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41219/solr
[junit4] 2> 645985 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 645986 INFO (zkConnectionManagerCallback-4716-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 645987 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 646089 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 646091 INFO (zkConnectionManagerCallback-4718-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 646091 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 646155 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:44725_
[junit4] 2> 646156 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.c.Overseer Overseer (id=72077690276675589-127.0.0.1:44725_-n_0000000000) starting
[junit4] 2> 646159 INFO (OverseerStateUpdate-72077690276675589-127.0.0.1:44725_-n_0000000000) [n:127.0.0.1:44725_ ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:44725_
[junit4] 2> 646159 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44725_
[junit4] 2> 646162 INFO (zkCallback-4717-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 646164 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 646165 WARN (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] 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> 646184 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 646216 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 646224 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 646224 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 646225 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [n:127.0.0.1:44725_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/control-001/cores
[junit4] 2> 646241 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 646241 INFO (zkConnectionManagerCallback-4727-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 646241 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 646242 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 646243 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41219/solr ready
[junit4] 2> 646307 INFO (qtp19535424-13917) [n:127.0.0.1:44725_ ] 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:44725_&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 646310 INFO (OverseerThreadFactory-2926-thread-1-processing-n:127.0.0.1:44725_) [n:127.0.0.1:44725_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 646420 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 646420 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ x:control_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 647435 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.0
[junit4] 2> 647449 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead
[junit4] 2> 647483 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 647638 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 647675 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at /configs/conf1/managed-schema
[junit4] 2> 647683 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/conf1/schema.xml to /configs/conf1/schema.xml.bak
[junit4] 2> 647683 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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 configset conf1, trusted=true
[junit4] 2> 647684 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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@13876ee
[junit4] 2> 647684 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 647687 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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=23, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=104.44140625, floorSegmentMB=1.7734375, forceMergeDeletesPctAllowed=10.580711819206952, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=47.27206357830325
[junit4] 2> 647691 WARN (qtp19535424-13921) [n:127.0.0.1:44725_ 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, registerPath=/solr,/v2, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 647760 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 647760 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 647763 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 647763 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 647765 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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=15, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 647766 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@12991d7[control_collection_shard1_replica_n1] main]
[junit4] 2> 647779 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 647780 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 647780 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema
[junit4] 2> 647781 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 647781 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 647781 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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 1656795520405864448
[junit4] 2> 647785 INFO (searcherExecutor-2931-thread-1-processing-n:127.0.0.1:44725_ x:control_collection_shard1_replica_n1 c:control_collection s:shard1) [n:127.0.0.1:44725_ 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@12991d7[control_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 647788 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 647788 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 647790 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 647790 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 647790 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to https://127.0.0.1:44725/control_collection_shard1_replica_n1/
[junit4] 2> 647790 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 647790 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy https://127.0.0.1:44725/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 647790 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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/72077690276675589-core_node2-n_0000000000
[junit4] 2> 647795 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: https://127.0.0.1:44725/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 647903 INFO (zkCallback-4717-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> 647903 INFO (zkCallback-4717-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> 647911 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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> 647916 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ 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=1496
[junit4] 2> 647922 INFO (qtp19535424-13917) [n:127.0.0.1:44725_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 648022 INFO (zkCallback-4717-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> 648022 INFO (zkCallback-4717-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> 648023 INFO (zkCallback-4717-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> 648024 INFO (qtp19535424-13917) [n:127.0.0.1:44725_ ] 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:44725_&wt=javabin&version=2} status=0 QTime=1717
[junit4] 2> 648025 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in collection: control_collection
[junit4] 2> 648139 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 648140 INFO (zkConnectionManagerCallback-4733-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 648140 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 648142 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 648146 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41219/solr ready
[junit4] 2> 648146 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 648153 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 648168 INFO (OverseerThreadFactory-2926-thread-2-processing-n:127.0.0.1:44725_) [n:127.0.0.1:44725_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 648172 INFO (OverseerCollectionConfigSetProcessor-72077690276675589-127.0.0.1:44725_-n_0000000000) [n:127.0.0.1:44725_ ] 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> 648412 WARN (OverseerThreadFactory-2926-thread-2-processing-n:127.0.0.1:44725_) [n:127.0.0.1:44725_ ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
[junit4] 2> 648416 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 648423 INFO (qtp19535424-13921) [n:127.0.0.1:44725_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2} status=0 QTime=269
[junit4] 2> 648431 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 648431 INFO (watches-4730-thread-1) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 648431 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 648431 INFO (watches-4730-thread-1) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 648431 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 648431 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 648431 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 648431 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 648431 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=4
[junit4] 2> 648534 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-1-001 of type NRT for shard2
[junit4] 2> 648542 WARN (closeThreadPool-4734-thread-1) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 648542 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 648542 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 648542 INFO (closeThreadPool-4734-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_201-b09
[junit4] 2> 648599 INFO (closeThreadPool-4734-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 648599 INFO (closeThreadPool-4734-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 648599 INFO (closeThreadPool-4734-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 648614 INFO (closeThreadPool-4734-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1ad498{/,null,AVAILABLE}
[junit4] 2> 648637 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-2-001 of type NRT for shard1
[junit4] 2> 648637 INFO (closeThreadPool-4734-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@e5adda{SSL,[ssl, http/1.1]}{127.0.0.1:44989}
[junit4] 2> 648637 INFO (closeThreadPool-4734-thread-1) [ ] o.e.j.s.Server Started @648664ms
[junit4] 2> 648637 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/tempDir-001/jetty1, replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/, hostPort=44989, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-1-001/cores}
[junit4] 2> 648638 ERROR (closeThreadPool-4734-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 648638 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 648638 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.5.0
[junit4] 2> 648638 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 648638 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 648638 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T12:55:36.205Z
[junit4] 2> 648646 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 648653 WARN (closeThreadPool-4734-thread-2) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 648653 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 648653 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 648653 INFO (closeThreadPool-4734-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_201-b09
[junit4] 2> 648659 INFO (zkConnectionManagerCallback-4736-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 648659 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 648661 INFO (closeThreadPool-4734-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 648661 INFO (closeThreadPool-4734-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 648662 INFO (closeThreadPool-4734-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 648662 INFO (closeThreadPool-4734-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1e49fa3{/,null,AVAILABLE}
[junit4] 2> 648667 INFO (closeThreadPool-4734-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@19b5d68{SSL,[ssl, http/1.1]}{127.0.0.1:45651}
[junit4] 2> 648667 INFO (closeThreadPool-4734-thread-2) [ ] o.e.j.s.Server Started @648694ms
[junit4] 2> 648667 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/tempDir-001/jetty2, replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/, hostPort=45651, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-2-001/cores}
[junit4] 2> 648667 ERROR (closeThreadPool-4734-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 648667 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 648667 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.5.0
[junit4] 2> 648667 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 648667 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 648667 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T12:55:36.234Z
[junit4] 2> 648669 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 648669 INFO (zkConnectionManagerCallback-4738-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 648670 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 648744 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-3-001 of type NRT for shard2
[junit4] 2> 648752 WARN (closeThreadPool-4734-thread-3) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 648752 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 648752 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 648752 INFO (closeThreadPool-4734-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_201-b09
[junit4] 2> 648762 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 648762 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-1-001/solr.xml
[junit4] 2> 648765 INFO (closeThreadPool-4734-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 648765 INFO (closeThreadPool-4734-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 648765 INFO (closeThreadPool-4734-thread-3) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 648766 INFO (closeThreadPool-4734-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@15654ef{/,null,AVAILABLE}
[junit4] 2> 648766 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 648766 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 648768 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 648789 INFO (closeThreadPool-4734-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@14a057{SSL,[ssl, http/1.1]}{127.0.0.1:33593}
[junit4] 2> 648789 INFO (closeThreadPool-4734-thread-3) [ ] o.e.j.s.Server Started @648816ms
[junit4] 2> 648789 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/tempDir-001/jetty3, replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/, hostPort=33593, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-3-001/cores}
[junit4] 2> 648790 ERROR (closeThreadPool-4734-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 648790 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 648790 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.5.0
[junit4] 2> 648790 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 648790 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 648790 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T12:55:36.357Z
[junit4] 2> 648798 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 648807 INFO (zkConnectionManagerCallback-4741-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 648807 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 648843 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-4-001 of type NRT for shard1
[junit4] 2> 648848 WARN (closeThreadPool-4734-thread-4) [ ] o.e.j.s.h.g.GzipHandler minGzipSize of 0 is inefficient for short content, break even is size 23
[junit4] 2> 648848 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 648848 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 648848 INFO (closeThreadPool-4734-thread-4) [ ] o.e.j.s.Server jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 1.8.0_201-b09
[junit4] 2> 648861 INFO (closeThreadPool-4734-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 648861 INFO (closeThreadPool-4734-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 648861 INFO (closeThreadPool-4734-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 648861 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 648861 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-2-001/solr.xml
[junit4] 2> 648861 INFO (closeThreadPool-4734-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@b05ca8{/,null,AVAILABLE}
[junit4] 2> 648863 INFO (closeThreadPool-4734-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1da7ed3{SSL,[ssl, http/1.1]}{127.0.0.1:34211}
[junit4] 2> 648863 INFO (closeThreadPool-4734-thread-4) [ ] o.e.j.s.Server Started @648890ms
[junit4] 2> 648863 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/tempDir-001/jetty4, replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/, hostPort=34211, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-4-001/cores}
[junit4] 2> 648863 ERROR (closeThreadPool-4734-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 648863 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 648863 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.5.0
[junit4] 2> 648863 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 648863 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 648863 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-01-26T12:55:36.430Z
[junit4] 2> 648866 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 648884 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 648884 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 648886 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 648886 INFO (zkConnectionManagerCallback-4743-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 648886 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 648961 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 648961 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-3-001/solr.xml
[junit4] 2> 648965 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 648965 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 648966 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 649062 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 649062 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-4-001/solr.xml
[junit4] 2> 649065 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 649065 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 649067 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 649534 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 649535 WARN (closeThreadPool-4734-thread-4) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 649539 WARN (closeThreadPool-4734-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2251af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 649539 WARN (closeThreadPool-4734-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2251af[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 649543 WARN (closeThreadPool-4734-thread-4) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 649544 WARN (closeThreadPool-4734-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@d8aeaf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 649544 WARN (closeThreadPool-4734-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@d8aeaf[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 649545 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41219/solr
[junit4] 2> 649547 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 649548 INFO (zkConnectionManagerCallback-4752-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 649548 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 649577 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 649578 WARN (closeThreadPool-4734-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 649578 WARN (closeThreadPool-4734-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@ce50fa[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 649578 WARN (closeThreadPool-4734-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@ce50fa[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 649587 WARN (closeThreadPool-4734-thread-1) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 649588 WARN (closeThreadPool-4734-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1bc4651[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 649588 WARN (closeThreadPool-4734-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1bc4651[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 649589 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41219/solr
[junit4] 2> 649592 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 649593 INFO (zkConnectionManagerCallback-4758-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 649593 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 649650 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 649659 INFO (zkConnectionManagerCallback-4760-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 649659 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 649666 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 649669 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.c.ZkController Publish node=127.0.0.1:34211_ as DOWN
[junit4] 2> 649670 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 649670 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:34211_
[junit4] 2> 649672 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 649673 WARN (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] 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> 649675 INFO (zkCallback-4732-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 649675 INFO (zkCallback-4717-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 649691 INFO (zkCallback-4759-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 649699 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 649721 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 649756 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 649756 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 649757 INFO (closeThreadPool-4734-thread-4) [n:127.0.0.1:34211_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-4-001/cores
[junit4] 2> 649758 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 649770 INFO (zkConnectionManagerCallback-4766-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 649771 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 649781 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 649785 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.c.ZkController Publish node=127.0.0.1:44989_ as DOWN
[junit4] 2> 649786 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 649786 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44989_
[junit4] 2> 649788 INFO (zkCallback-4759-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 649788 INFO (zkCallback-4732-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 649788 INFO (zkCallback-4717-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 649789 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 649790 WARN (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] 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> 649790 INFO (zkCallback-4765-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 649792 INFO (closeThreadPool-4734-thread-4) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:34211_
[junit4] 2> 649806 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 649827 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 649839 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 649839 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 649841 INFO (closeThreadPool-4734-thread-1) [n:127.0.0.1:44989_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-1-001/cores
[junit4] 2> 649907 INFO (closeThreadPool-4734-thread-1) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:44989_
[junit4] 2> 650180 INFO (OverseerCollectionConfigSetProcessor-72077690276675589-127.0.0.1:44725_-n_0000000000) [n:127.0.0.1:44725_ ] 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> 651163 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 651164 WARN (closeThreadPool-4734-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 651175 WARN (closeThreadPool-4734-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6f9ba5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 651175 WARN (closeThreadPool-4734-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6f9ba5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 651192 WARN (closeThreadPool-4734-thread-2) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 651211 WARN (closeThreadPool-4734-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@559e8e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 651211 WARN (closeThreadPool-4734-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@559e8e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 651213 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41219/solr
[junit4] 2> 651226 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651235 INFO (zkConnectionManagerCallback-4776-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 651235 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651358 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651361 INFO (zkConnectionManagerCallback-4778-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 651361 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651377 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 651382 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.c.ZkController Publish node=127.0.0.1:45651_ as DOWN
[junit4] 2> 651383 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 651383 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45651_
[junit4] 2> 651384 INFO (zkCallback-4765-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 651384 INFO (zkCallback-4759-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 651384 INFO (zkCallback-4732-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 651384 INFO (zkCallback-4717-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 651385 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 651386 WARN (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] 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> 651393 INFO (zkCallback-4777-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 651430 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 651453 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 651475 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 651475 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 651476 INFO (closeThreadPool-4734-thread-2) [n:127.0.0.1:45651_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-2-001/cores
[junit4] 2> 651551 INFO (closeThreadPool-4734-thread-2) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:45651_
[junit4] 2> 651738 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 651739 WARN (closeThreadPool-4734-thread-3) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 651750 WARN (closeThreadPool-4734-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@ecc87[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 651750 WARN (closeThreadPool-4734-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@ecc87[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 651767 WARN (closeThreadPool-4734-thread-3) [ ] o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 651775 WARN (closeThreadPool-4734-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@155abb3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 651775 WARN (closeThreadPool-4734-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@155abb3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 651776 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41219/solr
[junit4] 2> 651777 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651778 INFO (zkConnectionManagerCallback-4788-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 651778 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651886 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 651891 INFO (zkConnectionManagerCallback-4790-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 651891 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 651899 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 651903 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.c.ZkController Publish node=127.0.0.1:33593_ as DOWN
[junit4] 2> 651903 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 651903 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33593_
[junit4] 2> 651905 INFO (zkCallback-4777-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 651905 INFO (zkCallback-4759-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 651905 INFO (zkCallback-4717-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 651905 INFO (zkCallback-4789-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 651905 INFO (zkCallback-4732-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 651906 INFO (zkCallback-4765-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 651907 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 651907 WARN (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] 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> 651930 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 651966 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 651991 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 651991 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 651992 INFO (closeThreadPool-4734-thread-3) [n:127.0.0.1:33593_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-3-001/cores
[junit4] 2> 652086 INFO (closeThreadPool-4734-thread-3) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:33593_
[junit4] 2> 652231 INFO (qtp30430234-14076) [n:127.0.0.1:33593_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:44989_&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 652248 INFO (qtp30430234-14075) [n:127.0.0.1:33593_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:45651_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 652254 INFO (qtp30430234-14081) [n:127.0.0.1:33593_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:33593_&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 652256 INFO (OverseerThreadFactory-2926-thread-3-processing-n:127.0.0.1:44725_) [n:127.0.0.1:44725_ c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:44989_ for creating new replica of shard shard2 for collection collection1
[junit4] 2> 652258 INFO (OverseerThreadFactory-2926-thread-4-processing-n:127.0.0.1:44725_) [n:127.0.0.1:44725_ c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:45651_ for creating new replica of shard shard1 for collection collection1
[junit4] 2> 652259 INFO (qtp30430234-14080) [n:127.0.0.1:33593_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:34211_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 652259 INFO (OverseerThreadFactory-2926-thread-4-processing-n:127.0.0.1:44725_) [n:127.0.0.1:44725_ c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 652263 INFO (OverseerThreadFactory-2926-thread-3-processing-n:127.0.0.1:44725_) [n:127.0.0.1:44725_ c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 652418 INFO (qtp6072594-14088) [n:127.0.0.1:45651_ 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> 652418 INFO (qtp28055150-14091) [n:127.0.0.1:44989_ x:collection1_shard2_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n2&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 653448 INFO (qtp6072594-14088) [n:127.0.0.1:45651_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.0
[junit4] 2> 653475 INFO (qtp28055150-14091) [n:127.0.0.1:44989_ c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.5.0
[junit4] 2> 653489 INFO (qtp6072594-14088) [n:127.0.0.1:45651_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=test
[junit4] 2> 653494 INFO (qtp28055150-14091) [n:127.0.0.1:44989_ c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.s.IndexSchema [collection1_shard2_replica_n2] Schema name=test
[junit4] 2> 653720 INFO (qtp6072594-14088) [n:127.0.0.1:45651_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 653729 INFO (qtp28055150-14091) [n:127.0.0.1:44989_ c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 653751 INFO (qtp6072594-14088) [n:127.0.0.1:45651_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using configuration from configset conf1, trusted=true
[junit4] 2> 653752 INFO (qtp6072594-14088) [n:127.0.0.1:45651_ 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@13876ee
[junit4] 2> 653752 INFO (qtp6072594-14088) [n:127.0.0.1:45651_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-2-001/cores/collection1_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-2-001/cores/collection1_shard1_replica_n1/data/]
[junit4] 2> 653755 INFO (qtp6072594-14088) [n:127.0.0.1:45651_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=104.44140625, floorSegmentMB=1.7734375, forceMergeDeletesPctAllowed=10.580711819206952, segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0, deletesPctAllowed=47.27206357830325
[junit4] 2> 653759 WARN (qtp6072594-14088) [n:127.0.0.1:45651_ 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, registerPath=/solr,/v2, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 653803 INFO (qtp28055150-14091) [n:127.0.0.1:44989_ c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n2' using configuration from configset conf1, trusted=true
[junit4] 2> 653804 INFO (qtp28055150-14091) [n:127.0.0.1:44989_ c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard2.replica_n2' (registry 'solr.core.collection1.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13876ee
[junit4] 2> 653804 INFO (qtp28055150-14091) [n:127.0.0.1:44989_ c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.SolrCore [[collection1_shard2_replica_n2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-1-001/cores/collection1_shard2_replica_n2], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001/shard-1-001/cores/collection1_shard2_replica_n2/data
[...truncated too long message...]
.metrics.MetricRegistry@13882ea
[junit4] 2> 732917 INFO (closeThreadPool-124-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 732917 INFO (closeThreadPool-124-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 732918 INFO (zkCallback-91-thread-4) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 732919 INFO (closeThreadPool-124-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 732919 INFO (closeThreadPool-124-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@ffc870: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@b49f58
[junit4] 2> 732921 INFO (closeThreadPool-124-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 732921 INFO (closeThreadPool-124-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1da50d0: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@13882ea
[junit4] 2> 732921 INFO (closeThreadPool-124-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 733018 INFO (closeThreadPool-124-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@10637e6{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 733019 INFO (closeThreadPool-124-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@8f9135{/,null,UNAVAILABLE}
[junit4] 2> 733019 INFO (closeThreadPool-124-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 733116 INFO (closeThreadPool-124-thread-5) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1fa52d7{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 733116 INFO (closeThreadPool-124-thread-5) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@10ce6d7{/,null,UNAVAILABLE}
[junit4] 2> 733116 INFO (closeThreadPool-124-thread-5) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 733216 INFO (closeThreadPool-124-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1ed8f75{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 733216 INFO (closeThreadPool-124-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@e6ed65{/,null,UNAVAILABLE}
[junit4] 2> 733216 INFO (closeThreadPool-124-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 733316 INFO (closeThreadPool-124-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1ed4280{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 733316 INFO (closeThreadPool-124-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@715256{/,null,UNAVAILABLE}
[junit4] 2> 733316 INFO (closeThreadPool-124-thread-4) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 733416 INFO (closeThreadPool-124-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72077847721738245-127.0.0.1:36895_-n_0000000000) closing
[junit4] 2> 733416 INFO (closeThreadPool-124-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@146c86b{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 733416 INFO (closeThreadPool-124-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1e4b7e9{/,null,UNAVAILABLE}
[junit4] 2> 733416 INFO (closeThreadPool-124-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 733417 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 733620 WARN (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 17 /solr/collections/collection1/state.json
[junit4] 2> 17 /solr/configs/conf1/managed-schema
[junit4] 2> 15 /solr/configs/conf1
[junit4] 2> 7 /solr/aliases.json
[junit4] 2> 5 /solr/packages.json
[junit4] 2> 5 /solr/security.json
[junit4] 2> 5 /solr/collections/collection1/terms/shard1
[junit4] 2> 5 /solr/collections/collection1/terms/shard2
[junit4] 2> 4 /solr/collections/collection1/collectionprops.json
[junit4] 2> 2 /solr/collections/control_collection/terms/shard1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 68 /solr/clusterstate.json
[junit4] 2> 11 /solr/configs/conf1/managed-schema
[junit4] 2> 9 /solr/collections/control_collection/state.json
[junit4] 2> 7 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 36 /solr/overseer/queue
[junit4] 2> 30 /solr/live_nodes
[junit4] 2> 14 /solr/overseer/collection-queue-work
[junit4] 2> 7 /solr/collections
[junit4] 2>
[junit4] 2> 733632 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:33035
[junit4] 2> 733632 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:33035
[junit4] 2> 733632 INFO (TEST-TestBulkSchemaConcurrent.test-seed#[48E052775EAF7F39]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 33035
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestBulkSchemaConcurrent -Dtests.method=test -Dtests.seed=48E052775EAF7F39 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=fr -Dtests.timezone=America/Cordoba -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 730s J2 | TestBulkSchemaConcurrent.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: [[CopyField source=a0,dest=hello_lol0 not created, new type mystr0 not created, dynamic field *_lol0 not created, field a0 not created], [], [], [], []]
[junit4] > at __randomizedtesting.SeedInfo.seed([48E052775EAF7F39:C0B46DADF05312C1]:0)
[junit4] > at org.apache.solr.schema.TestBulkSchemaConcurrent.test(TestBulkSchemaConcurrent.java:94)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J2/temp/solr.schema.TestBulkSchemaConcurrent_48E052775EAF7F39-001
[junit4] 2> Jan 26, 2020 1:47:44 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84), sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@b1190), locale=fr, timezone=America/Cordoba
[junit4] 2> NOTE: Linux 5.3.0-26-generic i386/Oracle Corporation 1.8.0_201 (32-bit)/cpus=16,threads=2,free=160246240,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestBulkSchemaConcurrent]
[junit4] Completed [5/5 (2!)] on J2 in 733.48s, 1 test, 1 failure <<< FAILURES!
[...truncated 14 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/common-build.xml:1590: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/common-build.xml:1117: There were test failures: 5 suites, 5 tests, 2 failures [seed: 48E052775EAF7F39]
Total time: 12 minutes 20 seconds
[repro] Setting last failure code to 256
[repro] Failures w/original seeds:
[repro] 2/5 failed: org.apache.solr.schema.TestBulkSchemaConcurrent
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
No credentials specified
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=e934c8a7caee42565bd4c3982e6b46a561ebecfe, workspace=/home/jenkins/workspace/Lucene-Solr-8.x-Linux
[WARNINGS] Computing warning deltas based on reference build #1910
Recording test results
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2