You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2020/11/21 22:38:47 UTC
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 874 - Unstable!
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/874/
1 tests failed.
FAILED: org.apache.solr.util.TestSolrCLIRunExample.testInteractiveSolrCloudExampleWithAutoScalingPolicy
Error Message:
After running Solr cloud example, test collection 'testCloudExamplePrompt1' not found in Solr at: http://localhost:42513/solr; tool output: Welcome to the SolrCloud example! This interactive session will help you launch a SolrCloud cluster on your local workstation. To begin, how many Solr nodes would you like to run in your local cluster? (specify 1-4 nodes) [2]: Ok, let's start up 1 Solr nodes for your example SolrCloud cluster. Please enter the port for node1 [8983]: Creating Solr home directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/tempDir-006/cloud/node1/solr Starting up Solr on port 42513 using command: "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/bin/solr" start -cloud -p 42513 -s "temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/tempDir-006/cloud/node1/solr"
Stack Trace:
java.lang.AssertionError: After running Solr cloud example, test collection 'testCloudExamplePrompt1' not found in Solr at: http://localhost:42513/solr; tool output:
Welcome to the SolrCloud example!
This interactive session will help you launch a SolrCloud cluster on your local workstation.
To begin, how many Solr nodes would you like to run in your local cluster? (specify 1-4 nodes) [2]:
Ok, let's start up 1 Solr nodes for your example SolrCloud cluster.
Please enter the port for node1 [8983]:
Creating Solr home directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/tempDir-006/cloud/node1/solr
Starting up Solr on port 42513 using command:
"/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/bin/solr" start -cloud -p 42513 -s "temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/tempDir-006/cloud/node1/solr"
at __randomizedtesting.SeedInfo.seed([6354C47D9197E291:91FC7F72EE227BB7]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.apache.solr.util.TestSolrCLIRunExample.testInteractiveSolrCloudExampleWithAutoScalingPolicy(TestSolrCLIRunExample.java:570)
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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 16427 lines...]
[junit4] Suite: org.apache.solr.util.TestSolrCLIRunExample
[junit4] 2> 2464294 INFO (SUITE-TestSolrCLIRunExample-seed#[6354C47D9197E291]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 2464295 INFO (SUITE-TestSolrCLIRunExample-seed#[6354C47D9197E291]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/data-dir-193-001
[junit4] 2> 2464295 INFO (SUITE-TestSolrCLIRunExample-seed#[6354C47D9197E291]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2464296 INFO (SUITE-TestSolrCLIRunExample-seed#[6354C47D9197E291]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 2464296 INFO (SUITE-TestSolrCLIRunExample-seed#[6354C47D9197E291]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2464304 INFO (TEST-TestSolrCLIRunExample.testFailExecuteScript-seed#[6354C47D9197E291]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testFailExecuteScript
[junit4] 2>
[junit4] 2> ERROR: access denied ("java.io.FilePermission" "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/tempDir-001/failExecuteScript" "execute")
[junit4] 2>
[junit4] 2> 2464352 INFO (TEST-TestSolrCLIRunExample.testFailExecuteScript-seed#[6354C47D9197E291]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testFailExecuteScript
[junit4] 2> 2464356 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[6354C47D9197E291]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSchemalessExample
[junit4] 2> 2464356 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[6354C47D9197E291]) [ ] o.a.s.u.TestSolrCLIRunExample Selected port 41131 to start schemaless example Solr instance on ...
[junit4] 2> 2464361 INFO (Thread-4315) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=41131, binding port=41131)
[junit4] 2> 2464361 INFO (Thread-4315) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 41131 try number 2 ...
[junit4] 2> 2464361 INFO (Thread-4315) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2464375 INFO (Thread-4315) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2464375 INFO (Thread-4315) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2464375 INFO (Thread-4315) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2464375 INFO (Thread-4315) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@653ad4a1{/solr,null,AVAILABLE}
[junit4] 2> 2464376 INFO (Thread-4315) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4d27254d{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:41131}
[junit4] 2> 2464376 INFO (Thread-4315) [ ] o.e.j.s.Server Started @2464431ms
[junit4] 2> 2464376 INFO (Thread-4315) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=41131}
[junit4] 2> 2464376 INFO (Thread-4315) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2464376 INFO (Thread-4315) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.8.0
[junit4] 2> 2464376 INFO (Thread-4315) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port 41131
[junit4] 2> 2464376 INFO (Thread-4315) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 2464376 INFO (Thread-4315) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-21T22:19:56.538Z
[junit4] 2> 2464376 INFO (Thread-4315) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/tempDir-002/schemaless/solr/solr.xml
[junit4] 2> 2464380 INFO (Thread-4315) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@2f9bf008, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2465425 INFO (Thread-4315) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2465426 WARN (Thread-4315) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@36a226a4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2465426 WARN (Thread-4315) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@36a226a4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2465428 WARN (Thread-4315) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1841d31e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2465428 WARN (Thread-4315) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1841d31e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2465429 WARN (Thread-4315) [ ] 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> 2465440 INFO (Thread-4315) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2465440 INFO (Thread-4315) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2465456 INFO (Thread-4315) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2f9bf008
[junit4] 2> 2465462 INFO (Thread-4315) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2f9bf008
[junit4] 2> 2465462 INFO (Thread-4315) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2f9bf008
[junit4] 2> 2465463 INFO (Thread-4315) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/tempDir-002/schemaless/solr
[junit4] 2> 2466389 INFO (qtp153298613-35398) [ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/info/system params={wt=json} status=0 QTime=3
[junit4] 2> 2466393 INFO (qtp153298613-35396) [ x:gettingstarted ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={core=gettingstarted&action=STATUS&wt=json} status=0 QTime=0
[junit4] 2> 2466754 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@4d27254d{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:41131}
[junit4] 2> 2466754 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@653ad4a1{/solr,null,STOPPED}
[junit4] 2> 2466754 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2466756 INFO (Thread-4325) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2466758 INFO (Thread-4325) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2466758 INFO (Thread-4325) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2466758 INFO (Thread-4325) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2466758 INFO (Thread-4325) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@32c2152{/solr,null,AVAILABLE}
[junit4] 2> 2466759 INFO (Thread-4325) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2269de1{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42509}
[junit4] 2> 2466759 INFO (Thread-4325) [ ] o.e.j.s.Server Started @2466814ms
[junit4] 2> 2467819 WARN (Thread-4325) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@45383b77[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2467819 WARN (Thread-4325) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@45383b77[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2467821 WARN (Thread-4325) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@72a9f4ff[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2467821 WARN (Thread-4325) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@72a9f4ff[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2467822 WARN (Thread-4325) [ ] 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> 2471795 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2269de1{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42509}
[junit4] 2> 2471796 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@32c2152{/solr,null,STOPPED}
[junit4] 2> 2471796 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2471802 INFO (Thread-4335) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2471809 INFO (Thread-4335) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2471809 INFO (Thread-4335) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2471809 INFO (Thread-4335) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2471809 INFO (Thread-4335) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@16fb74fd{/solr,null,AVAILABLE}
[junit4] 2> 2471809 INFO (Thread-4335) [ ] o.e.j.s.AbstractConnector Started ServerConnector@185925c5{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42813}
[junit4] 2> 2471810 INFO (Thread-4335) [ ] o.e.j.s.Server Started @2471865ms
[junit4] 2> 2472153 WARN (Thread-4335) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@25b9a619[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2472153 WARN (Thread-4335) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@25b9a619[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2472160 WARN (Thread-4335) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@42060d74[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2472160 WARN (Thread-4335) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@42060d74[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2472161 WARN (Thread-4335) [ ] 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> 2476864 WARN (qtp613212737-35461) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/extraction/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/extraction/lib
[junit4] 2> 2476864 WARN (qtp613212737-35461) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-cell-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 2476864 WARN (qtp613212737-35461) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/langid/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/langid/lib
[junit4] 2> 2476864 WARN (qtp613212737-35461) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-langid-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 2476865 WARN (qtp613212737-35461) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-ltr-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 2476865 WARN (qtp613212737-35461) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/velocity/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/velocity/lib
[junit4] 2> 2476865 WARN (qtp613212737-35461) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-velocity-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 1> SimplePostTool version 5.0.0
[junit4] 1> Posting files to [base] url http://localhost:42813/solr/techproducts/update using content-type application/xml...
[junit4] 1> POSTing file mp500.xml to [base]
[junit4] 1> POSTing file ipod_video.xml to [base]
[junit4] 1> POSTing file monitor2.xml to [base]
[junit4] 1> POSTing file gb18030-example.xml to [base]
[junit4] 1> POSTing file vidcard.xml to [base]
[junit4] 1> POSTing file money.xml to [base]
[junit4] 1> POSTing file hd.xml to [base]
[junit4] 1> POSTing file ipod_other.xml to [base]
[junit4] 1> POSTing file sd500.xml to [base]
[junit4] 1> POSTing file solr.xml to [base]
[junit4] 1> POSTing file utf8-example.xml to [base]
[junit4] 1> POSTing file monitor.xml to [base]
[junit4] 1> POSTing file manufacturers.xml to [base]
[junit4] 1> POSTing file mem.xml to [base]
[junit4] 1> 14 files indexed.
[junit4] 1> COMMITting Solr index changes to http://localhost:42813/solr/techproducts/update...
[junit4] 1> Time spent: 0:00:00.269
[junit4] 2> 2477501 INFO (TEST-TestSolrCLIRunExample.testTechproductsExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@185925c5{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42813}
[junit4] 2> 2477501 INFO (TEST-TestSolrCLIRunExample.testTechproductsExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@16fb74fd{/solr,null,STOPPED}
[junit4] 2> 2477501 INFO (TEST-TestSolrCLIRunExample.testTechproductsExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2477503 INFO (Thread-4345) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2477503 INFO (Thread-4345) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2477503 INFO (Thread-4345) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2477503 INFO (Thread-4345) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2477504 INFO (Thread-4345) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@48d2cf67{/solr,null,AVAILABLE}
[junit4] 2> 2477504 INFO (Thread-4345) [ ] o.e.j.s.AbstractConnector Started ServerConnector@76d2642{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42625}
[junit4] 2> 2477504 INFO (Thread-4345) [ ] o.e.j.s.Server Started @2477559ms
[junit4] 2> 2479415 WARN (Thread-4345) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@4f92ac2f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2479415 WARN (Thread-4345) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@4f92ac2f[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2479419 WARN (Thread-4345) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@95121cd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2479419 WARN (Thread-4345) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@95121cd[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2479420 WARN (Thread-4345) [ ] 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> 2479467 WARN (coreLoadExecutor-21294-thread-1) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/extraction/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/extraction/lib
[junit4] 2> 2479468 WARN (coreLoadExecutor-21294-thread-1) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-cell-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 2479468 WARN (coreLoadExecutor-21294-thread-1) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/langid/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/langid/lib
[junit4] 2> 2479468 WARN (coreLoadExecutor-21294-thread-1) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-langid-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 2479468 WARN (coreLoadExecutor-21294-thread-1) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-ltr-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 2479468 WARN (coreLoadExecutor-21294-thread-1) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/velocity/lib filtered by .*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/contrib/velocity/lib
[junit4] 2> 2479468 WARN (coreLoadExecutor-21294-thread-1) [ x:techproducts ] o.a.s.c.SolrConfig Couldn't add files from /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist filtered by solr-velocity-\d.*\.jar to classpath: java.nio.file.NoSuchFileException: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/dist
[junit4] 2> 2482545 INFO (TEST-TestSolrCLIRunExample.testTechproductsExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@76d2642{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42625}
[junit4] 2> 2482545 INFO (TEST-TestSolrCLIRunExample.testTechproductsExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@48d2cf67{/solr,null,STOPPED}
[junit4] 2> 2482545 INFO (TEST-TestSolrCLIRunExample.testTechproductsExample-seed#[6354C47D9197E291]) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2482553 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 2482761 INFO (jetty-launcher-21311-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2482761 INFO (jetty-launcher-21311-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2482761 INFO (jetty-launcher-21311-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2482761 INFO (jetty-launcher-21311-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2482762 INFO (jetty-launcher-21311-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@24e5adec{/solr,null,AVAILABLE}
[junit4] 2> 2482762 INFO (jetty-launcher-21311-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1fbebd1a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:46489}
[junit4] 2> 2482762 INFO (jetty-launcher-21311-thread-1) [ ] o.e.j.s.Server Started @2482817ms
[junit4] 2> 2483671 WARN (jetty-launcher-21311-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@33af8253[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2483671 WARN (jetty-launcher-21311-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@33af8253[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2483673 WARN (jetty-launcher-21311-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6b123324[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2483673 WARN (jetty-launcher-21311-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6b123324[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2483846 WARN (jetty-launcher-21311-thread-1) [n:localhost:46489_solr ] 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> 2484174 WARN (OverseerThreadFactory-21333-thread-1-processing-n:localhost:46489_solr) [n:localhost:46489_solr ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 2 on collection testCloudExamplePrompt is higher than the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 2487735 WARN (zkCallback-21325-thread-4) [ ] o.a.s.c.LeaderElector Our node is no longer in line to be leader
[junit4] 2> 2488092 WARN (jetty-launcher-21311-thread-1-SendThread(127.0.0.1:36355)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x101a3cfae3c0005.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x101a3cfae3c0005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x101a3cfae3c0005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 2488193 INFO (jetty-closer-21434-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1fbebd1a{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:46489}
[junit4] 2> 2488194 INFO (jetty-closer-21434-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@24e5adec{/solr,null,STOPPED}
[junit4] 2> 2488194 INFO (jetty-closer-21434-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2488397 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> 8 /solr/configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 7 /solr/collections/testCloudExamplePrompt/terms/shard1
[junit4] 2> 6 /solr/clusterprops.json
[junit4] 2> 6 /solr/collections/testCloudExamplePrompt/terms/shard2
[junit4] 2> 6 /solr/aliases.json
[junit4] 2> 5 /solr/collections/testCloudExamplePrompt/state.json
[junit4] 2> 2 /solr/configs/testCloudExamplePrompt
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 21 /solr/collections/testCloudExamplePrompt/state.json
[junit4] 2> 6 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 27 /solr/overseer/queue
[junit4] 2> 12 /solr/collections
[junit4] 2> 9 /solr/overseer/collection-queue-work
[junit4] 2> 7 /solr/live_nodes
[junit4] 2>
[junit4] 2> 2488410 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 2488618 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2488619 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2488619 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2488619 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2488619 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2488619 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2488619 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2488619 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2491620 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2491621 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2491621 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2491621 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2491621 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2491621 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2491622 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2491622 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2494622 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2494623 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2494623 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2494623 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2494623 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2494623 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2494624 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2494624 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2497624 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2497625 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2497625 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2497625 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2497625 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2497626 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2497626 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2497626 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2500626 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2500627 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2500627 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2500627 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2500627 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2500628 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2500628 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2500628 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2503628 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2503629 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2503629 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2503630 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2503630 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2503630 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2503630 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2503630 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2506631 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2506632 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2506632 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2506632 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2506632 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2506632 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2506632 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2506632 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2509633 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2509634 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2509634 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2509634 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2509634 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2509634 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2509634 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2509634 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2512635 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2512636 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2512636 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2512636 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2512637 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2512637 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2512637 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2512637 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2515638 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2515638 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2515638 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2515638 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2515639 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2515639 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2515639 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2515639 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2518640 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2518640 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2518640 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2518640 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2518641 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2518641 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2518641 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2518641 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2521642 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2521643 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2521643 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2521643 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2521643 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2521644 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2521644 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2521644 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2524644 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2524645 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2524645 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2524645 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2524645 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2524646 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2524646 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2524646 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2527646 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2527647 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2527647 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2527647 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2527647 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2527648 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2527648 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2527648 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2530648 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2530649 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2530649 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2530649 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2530649 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2530650 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2530650 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2530650 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2533651 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2533651 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2533651 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2533651 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2533652 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2533652 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2533652 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2533652 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2536653 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2536653 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2536653 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2536654 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2536654 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2536654 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2536654 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2536654 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2539655 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2539655 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2539656 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2539656 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2539656 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2539656 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2539656 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2539656 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2542657 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2542658 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2542658 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2542658 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2542658 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2542658 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2542659 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2542659 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2545659 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 2545660 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2545660 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2545660 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2545660 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2215440e{/solr,null,AVAILABLE}
[junit4] 2> 2545660 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@68d19be9{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:42513}
[junit4] 2> 2545661 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2215440e{/solr,null,STOPPED}
[junit4] 2> 2545661 INFO (jetty-launcher-21447-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 2548764 WARN (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExampleWithAutoScalingPolicy-seed#[6354C47D9197E291]-SendThread(127.0.0.1:42513)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x101a3cfc51c0001.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x101a3cfc51c0001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x101a3cfc51c0001, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2>
[junit4] 2> ERROR: java.lang.Exception: Error starting up MiniSolrCloudCluster
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSolrCLIRunExample -Dtests.method=testInteractiveSolrCloudExampleWithAutoScalingPolicy -Dtests.seed=6354C47D9197E291 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=el-GR -Dtests.timezone=America/St_Thomas -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 65.5s J1 | TestSolrCLIRunExample.testInteractiveSolrCloudExampleWithAutoScalingPolicy <<<
[junit4] > Throwable #1: java.lang.AssertionError: After running Solr cloud example, test collection 'testCloudExamplePrompt1' not found in Solr at: http://localhost:42513/solr; tool output:
[junit4] > Welcome to the SolrCloud example!
[junit4] > This interactive session will help you launch a SolrCloud cluster on your local workstation.
[junit4] > To begin, how many Solr nodes would you like to run in your local cluster? (specify 1-4 nodes) [2]:
[junit4] > Ok, let's start up 1 Solr nodes for your example SolrCloud cluster.
[junit4] > Please enter the port for node1 [8983]:
[junit4] > Creating Solr home directory /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/tempDir-006/cloud/node1/solr
[junit4] > Starting up Solr on port 42513 using command:
[junit4] > "/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/bin/solr" start -cloud -p 42513 -s "temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001/tempDir-006/cloud/node1/solr"
[junit4] > at __randomizedtesting.SeedInfo.seed([6354C47D9197E291:91FC7F72EE227BB7]:0)
[junit4] > at org.apache.solr.util.TestSolrCLIRunExample.testInteractiveSolrCloudExampleWithAutoScalingPolicy(TestSolrCLIRunExample.java:570)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_6354C47D9197E291-001
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=el-GR, timezone=America/St_Thomas
[junit4] 2> NOTE: Linux 4.15.0-112-generic amd64/Oracle Corporation 1.8.0_252 (64-bit)/cpus=4,threads=1,free=251377784,total=523763712
[junit4] 2> NOTE: All tests run in this JVM: [PeerSyncWithIndexFingerprintCachingTest, DistributedFacetPivotSmallTest, LeaderTragicEventTest, TestRequestForwarding, TestUnifiedSolrHighlighter, CustomTermsComponentTest, TestStressThreadBackup, ZkCLITest, SegmentsInfoRequestHandlerTest, TestSha256AuthenticationProvider, HdfsChaosMonkeyNothingIsSafeTest, TestAddFieldRealTimeGet, TestComplexPhraseQParserPlugin, TestLRUCache, BigEndianAscendingWordDeserializerTest, TestConfigSetImmutable, SOLR749Test, TestInPlaceUpdateWithRouteField, ImplicitSnitchTest, CrossCollectionJoinQueryTest, TestCloudInspectUtil, TestFieldCollectionResource, TestBadConfig, StatsReloadRaceTest, DirectoryFactoryTest, BJQParserTest, ShardSplitTest, BasicAuthOnSingleNodeTest, MetricsHandlerTest, ComputePlanActionTest, DistributedQueryComponentOptimizationTest, TestShardHandlerFactory, DistributedTermsComponentTest, UUIDUpdateProcessorFallbackTest, ManagedSchemaRoundRobinCloudTest, ChaosMonkeyNothingIsSafeTest, SearchHandlerTest, TestZkAclsWithHadoopAuth, TestPayloadCheckQParserPlugin, HdfsTlogReplayBufferedWhileIndexingTest, QueryResultKeyTest, TestHashQParserPlugin, ProtectedTermFilterFactoryTest, TestXmlQParser, CachingDirectoryFactoryTest, BufferStoreTest, CollectionReloadTest, TestSolrDeletionPolicy2, ClassificationUpdateProcessorFactoryTest, MoveReplicaHDFSTest, AnalysisErrorHandlingTest, ClusterStateTest, TestSQLHandler, PolyFieldTest, TestPackages, ZookeeperStatusHandlerTest, TestClusterStateMutator, FullHLLTest, TestElisionMultitermQuery, MetricTriggerTest, TestJsonFacetErrors, TestReversedWildcardFilterFactory, TestSolrCoreProperties, DefaultValueUpdateProcessorTest, TestJavabinTupleStreamParser, SpellCheckCollatorTest, TestBlendedInfixSuggestions, TestMultiValuedNumericRangeQuery, TestReRankQParserPlugin, UpdateLogTest, CloudMLTQParserTest, TestJoin, TermsComponentTest, TestFacetMethods, TestLeaderElectionWithEmptyReplica, TestSimDistribStateManager, TestSolrQueryParser, ShardRoutingTest, AtomicUpdateJavabinTest, XmlUpdateRequestHandlerTest, SolrLogAuditLoggerPluginTest, TaggingAttributeTest, TestSuggestSpellingConverter, TestChildDocTransformerHierarchy, TestSerializedLuceneMatchVersion, PhrasesIdentificationComponentTest, ChangedSchemaMergeTest, StatelessScriptUpdateProcessorFactoryTest, SuggesterTest, ConcurrentCreateCollectionTest, TestOnReconnectListenerSupport, NodeLostTriggerTest, ReindexCollectionTest, TestSubQueryTransformerDistrib, TestCollationFieldDocValues, TestBulkSchemaConcurrent, TestSimPolicyCloud, HttpPartitionOnCommitTest, CdcrWithNodesRestartsTest, TestReplicationHandlerBackup, TestManagedSchemaThreadSafety, SoftAutoCommitTest, TestInitParams, InfoHandlerTest, SolrCoreMetricManagerTest, DistributedIntervalFacetingTest, TestConfigsApi, TestLegacyField, TestMissingGroups, TlogReplayBufferedWhileIndexingTest, ZkShardTermsTest, DeleteInactiveReplicaTest, DeleteStatusTest, DistribDocExpirationUpdateProcessorTest, MetricsHistoryWithAuthIntegrationTest, MigrateRouteKeyTest, OverseerTest, RecoveryZkTest, RestartWhileUpdatingTest, RouteFieldTest, RoutingToNodesWithPropertiesTest, SSLMigrationTest, SaslZkACLProviderTest, ShardRoutingCustomTest, SolrCLIZkUtilsTest, SolrXmlInZkTest, SplitShardTest, TestCloudRecovery, TestCloudSearcherWarming, TestDistributedMap, TestDownShardTolerantSearch, TestExclusionRuleCollectionAccess, TestRandomFlRTGCloud, TestSizeLimitedDistributedMap, TestSkipOverseerOperations, TestSolrCloudWithSecureImpersonation, TestStressInPlaceUpdates, TestWithCollection, IndexSizeTriggerMixedBoundsTest, TestSimClusterStateProvider, TestSimLargeCluster, TestSolrConfigHandlerConcurrent, CoreAdminCreateDiscoverTest, CoreAdminOperationTest, CoreMergeIndexesAdminHandlerTest, HealthCheckHandlerTest, DistributedFacetPivotLargeTest, SuggestComponentContextFilterQueryTest, TermVectorComponentDistributedTest, JavabinLoaderTest, RandomizedTaggerTest, HighlighterTest, UninvertDocValuesMergePolicyTest, TestLogWatcher, MetricsConfigTest, MetricsDisabledCloudTest, SolrJmxReporterCloudTest, SolrSlf4jReporterTest, SolrShardReporterTest, SubstringBytesRefFilterTest, TestRemoteStreaming, TestUnInvertedFieldException, TestWriterPerf, TestCSVResponseWriter, TestGeoJSONResponseWriter, TestRawTransformer, TestRetrieveFieldsOptimizer, TestSubQueryTransformerCrossCore, TestCopyFieldCollectionResource, TestSchemaResource, TestManagedSynonymGraphFilterFactory, DocValuesTest, TestBinaryField, TestSchemaField, TestSchemalessBufferedUpdates, TestUseDocValuesAsStored2, CursorMarkTest, FuzzySearchTest, MergeStrategyTest, TestFiltering, TestSimpleQParserPlugin, TestSolr4Spatial, TestStressLucene, TestStressUserVersions, TestStressVersions, TestTrieFacet, SpatialHeatmapFacetsTest, TestExactSharedStatsCache, AuditLoggerIntegrationTest, TestUninvertingReader, DocumentBuilderTest, PeerSyncTest, CategoryRoutedAliasUpdateProcessorTest, CloneFieldUpdateProcessorFactoryTest, DocExpirationUpdateProcessorFactoryTest, AuthToolTest, CircularListTest, DOMUtilTest, DateMathParserTest, DynamicMapsTest, NumberUtilsTest, PrimUtilsTest, SolrLogPostToolTest, TestCircuitBreaker, TestMaxTokenLenTokenizer, TestObjectReleaseTracker, TestSolrCLIRunExample]
[junit4] Completed [921/921 (1!)] on J1 in 89.84s, 5 tests, 1 failure <<< FAILURES!
[...truncated 50668 lines...]
[JENKINS] Lucene » Lucene-Solr-Tests-8.x - Build # 875 - Still Unstable!
Posted by Apache Jenkins Server <je...@builds.apache.org>.
Build: https://ci-builds.apache.org/job/Lucene/job/Lucene-Solr-Tests-8.x/875/
1 tests failed.
FAILED: org.apache.solr.cloud.MoveReplicaTest.testFailedMove
Error Message:
expected:<100> but was:<56>
Stack Trace:
java.lang.AssertionError: expected:<100> but was:<56>
at __randomizedtesting.SeedInfo.seed([4F9D91938CAF9763:E55042613B7C42B3]:0)
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.failNotEquals(Assert.java:835)
at org.junit.Assert.assertEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:633)
at org.apache.solr.cloud.MoveReplicaTest.testFailedMove(MoveReplicaTest.java:309)
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 com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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.junit.rules.RunRules.evaluate(RunRules.java:20)
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 org.junit.rules.RunRules.evaluate(RunRules.java:20)
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 13453 lines...]
[junit4] Suite: org.apache.solr.cloud.MoveReplicaTest
[junit4] 2> 160056 INFO (SUITE-MoveReplicaTest-seed#[4F9D91938CAF9763]-worker) [ ] o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to test-framework derived value of '/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/server/solr/configsets/_default/conf'
[junit4] 2> 160056 INFO (SUITE-MoveReplicaTest-seed#[4F9D91938CAF9763]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/data-dir-23-001
[junit4] 2> 160056 WARN (SUITE-MoveReplicaTest-seed#[4F9D91938CAF9763]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=7 numCloses=7
[junit4] 2> 160056 INFO (SUITE-MoveReplicaTest-seed#[4F9D91938CAF9763]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 160058 INFO (SUITE-MoveReplicaTest-seed#[4F9D91938CAF9763]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 160058 INFO (SUITE-MoveReplicaTest-seed#[4F9D91938CAF9763]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 160060 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 160061 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001
[junit4] 2> 160061 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 160062 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port: 0.0.0.0/0.0.0.0:0
[junit4] 2> 160062 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 160063 WARN (ZkTestServer Run Thread) [ ] o.a.z.s.ServerCnxnFactory maxCnxns is not configured, using default value 0.
[junit4] 2> 160162 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.ZkTestServer start zk server on port: 36445
[junit4] 2> 160162 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:36445
[junit4] 2> 160162 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:36445
[junit4] 2> 160162 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 36445
[junit4] 2> 160164 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160169 INFO (zkConnectionManagerCallback-1121-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160169 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160176 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160178 INFO (zkConnectionManagerCallback-1123-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160178 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160181 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160185 INFO (zkConnectionManagerCallback-1125-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160185 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160288 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 160288 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 160288 INFO (jetty-launcher-1126-thread-1) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 160289 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 160289 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 160289 INFO (jetty-launcher-1126-thread-2) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 160289 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 160290 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 160290 INFO (jetty-launcher-1126-thread-3) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 160291 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 160291 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 2 ...
[junit4] 2> 160291 INFO (jetty-launcher-1126-thread-4) [ ] o.e.j.s.Server jetty-9.4.34.v20201102; built: 2020-11-02T14:15:39.302Z; git: e46af88704a893fc12cb0e3bf46e2c7b48a009e7; jvm 1.8.0_252-b09
[junit4] 2> 160325 INFO (jetty-launcher-1126-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 160325 INFO (jetty-launcher-1126-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 160325 INFO (jetty-launcher-1126-thread-4) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 160325 INFO (jetty-launcher-1126-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 160325 INFO (jetty-launcher-1126-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 160326 INFO (jetty-launcher-1126-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 160326 INFO (jetty-launcher-1126-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@62d88d4{/solr,null,AVAILABLE}
[junit4] 2> 160346 INFO (jetty-launcher-1126-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 160346 INFO (jetty-launcher-1126-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 160347 INFO (jetty-launcher-1126-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 160347 INFO (jetty-launcher-1126-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 160347 INFO (jetty-launcher-1126-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 160347 INFO (jetty-launcher-1126-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 160347 INFO (jetty-launcher-1126-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@9388023{/solr,null,AVAILABLE}
[junit4] 2> 160357 INFO (jetty-launcher-1126-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1dea3235{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:३६४९९}
[junit4] 2> 160357 INFO (jetty-launcher-1126-thread-1) [ ] o.e.j.s.Server Started @१६०३८४ms
[junit4] 2> 160357 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36499}
[junit4] 2> 160357 INFO (jetty-launcher-1126-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7e064a4c{/solr,null,AVAILABLE}
[junit4] 2> 160357 ERROR (jetty-launcher-1126-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 160357 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 160357 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 160357 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 160357 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 160357 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-21T23:09:29.098Z
[junit4] 2> 160358 INFO (jetty-launcher-1126-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5da13c05{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:४५४०३}
[junit4] 2> 160358 INFO (jetty-launcher-1126-thread-4) [ ] o.e.j.s.Server Started @१६०३८५ms
[junit4] 2> 160358 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45403}
[junit4] 2> 160358 ERROR (jetty-launcher-1126-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 160358 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 160358 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 160358 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 160358 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 160358 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-21T23:09:29.099Z
[junit4] 2> 160367 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160367 INFO (jetty-launcher-1126-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7e39a67e{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:३८१३३}
[junit4] 2> 160367 INFO (jetty-launcher-1126-thread-2) [ ] o.e.j.s.Server Started @१६०३९४ms
[junit4] 2> 160367 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=38133}
[junit4] 2> 160367 ERROR (jetty-launcher-1126-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 160367 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 160367 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 160367 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 160367 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 160367 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-21T23:09:29.108Z
[junit4] 2> 160368 INFO (jetty-launcher-1126-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@26657ca6{/solr,null,AVAILABLE}
[junit4] 2> 160374 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160374 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160377 INFO (zkConnectionManagerCallback-1130-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160377 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160378 INFO (jetty-launcher-1126-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@412631cd{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:४४४१९}
[junit4] 2> 160378 INFO (jetty-launcher-1126-thread-3) [ ] o.e.j.s.Server Started @१६०४०५ms
[junit4] 2> 160378 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44419}
[junit4] 2> 160378 ERROR (jetty-launcher-1126-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 160378 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 160378 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.8.0
[junit4] 2> 160378 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 160378 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr
[junit4] 2> 160378 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2020-11-21T23:09:29.119Z
[junit4] 2> 160379 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 160383 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 160383 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 160384 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 160386 INFO (zkConnectionManagerCallback-1128-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160386 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160386 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 160386 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 160389 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 160389 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 160390 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 160392 WARN (jetty-launcher-1126-thread-4-SendThread(127.0.0.1:36445)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x101a3fef4990004.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef4990004, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef4990004, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 160392 INFO (zkConnectionManagerCallback-1132-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160392 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160392 WARN (jetty-launcher-1126-thread-1-SendThread(127.0.0.1:36445)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x101a3fef4990003.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef4990003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef4990003, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 160441 INFO (zkConnectionManagerCallback-1134-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 160441 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 160498 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 160593 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 160595 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 160595 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 160597 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 160599 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 160599 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 160600 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 160601 WARN (jetty-launcher-1126-thread-2-SendThread(127.0.0.1:36445)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x101a3fef4990005.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef4990005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef4990005, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 161129 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 161159 WARN (jetty-launcher-1126-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1d2ef30c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 161159 WARN (jetty-launcher-1126-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1d2ef30c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 161185 WARN (jetty-launcher-1126-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@22bc0913[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 161186 WARN (jetty-launcher-1126-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@22bc0913[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 161186 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36445/solr
[junit4] 2> 161201 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 161211 INFO (zkConnectionManagerCallback-1154-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 161212 INFO (jetty-launcher-1126-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 161233 WARN (jetty-launcher-1126-thread-2-SendThread(127.0.0.1:36445)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x101a3fef4990007.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef4990007, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef4990007, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 161497 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 161505 INFO (zkConnectionManagerCallback-1156-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 161505 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 161557 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:38133_solr
[junit4] 2> 161558 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.c.Overseer Overseer (id=72519384435326984-127.0.0.1:38133_solr-n_0000000000) starting
[junit4] 2> 161569 INFO (OverseerStateUpdate-72519384435326984-127.0.0.1:38133_solr-n_0000000000) [n:127.0.0.1:38133_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:38133_solr
[junit4] 2> 161597 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38133_solr
[junit4] 2> 161600 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 161601 WARN (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] 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> 161621 INFO (zkCallback-1155-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 161649 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 161673 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 161683 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 161683 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 161684 INFO (jetty-launcher-1126-thread-2) [n:127.0.0.1:38133_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node2
[junit4] 2> 161934 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 161942 WARN (jetty-launcher-1126-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@40bbd72e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 161942 WARN (jetty-launcher-1126-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@40bbd72e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 162279 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 162281 WARN (jetty-launcher-1126-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@57f429d2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 162281 WARN (jetty-launcher-1126-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@57f429d2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 162282 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36445/solr
[junit4] 2> 162297 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 162305 WARN (jetty-launcher-1126-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6f1b8b41[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 162306 WARN (jetty-launcher-1126-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6f1b8b41[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 162313 INFO (zkConnectionManagerCallback-1179-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 162313 INFO (jetty-launcher-1126-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 162345 WARN (jetty-launcher-1126-thread-4) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@1c5f409d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 162345 WARN (jetty-launcher-1126-thread-4) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@1c5f409d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 162346 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36445/solr
[junit4] 2> 162363 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 162381 INFO (zkConnectionManagerCallback-1184-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 162381 INFO (jetty-launcher-1126-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 162385 WARN (jetty-launcher-1126-thread-4-SendThread(127.0.0.1:36445)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x101a3fef499000a.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef499000a, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x101a3fef499000a, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 162464 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 162472 INFO (zkConnectionManagerCallback-1186-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 162472 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 162489 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 162492 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:36499_solr as DOWN
[junit4] 2> 162492 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 162492 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36499_solr
[junit4] 2> 162504 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 162506 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 162507 WARN (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] 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> 162521 INFO (zkConnectionManagerCallback-1188-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 162521 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 162524 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 162527 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:45403_solr as DOWN
[junit4] 2> 162528 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 162528 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45403_solr
[junit4] 2> 162533 INFO (zkCallback-1185-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 162533 INFO (zkCallback-1155-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 162536 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 162536 WARN (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] 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> 162545 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 162555 INFO (zkCallback-1187-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 162575 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 162577 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 162987 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 163007 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 163014 INFO (jetty-launcher-1126-thread-1) [n:127.0.0.1:36499_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node1
[junit4] 2> 163019 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 163033 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 163033 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 163034 INFO (jetty-launcher-1126-thread-4) [n:127.0.0.1:45403_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node4
[junit4] 2> 163918 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 163919 WARN (jetty-launcher-1126-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@5efaef8a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 163919 WARN (jetty-launcher-1126-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@5efaef8a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 163922 WARN (jetty-launcher-1126-thread-3) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@9fffb0a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 163922 WARN (jetty-launcher-1126-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@9fffb0a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 163923 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36445/solr
[junit4] 2> 163924 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 163925 INFO (zkConnectionManagerCallback-1212-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 163925 INFO (jetty-launcher-1126-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 164027 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 164028 INFO (zkConnectionManagerCallback-1214-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 164028 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 164035 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 164039 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:44419_solr as DOWN
[junit4] 2> 164039 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 164039 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:44419_solr
[junit4] 2> 164041 INFO (zkCallback-1185-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 164041 INFO (zkCallback-1155-thread-2) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 164041 INFO (zkCallback-1187-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 164041 INFO (zkCallback-1213-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 164042 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.p.PackageLoader /packages.json updated to version -1
[junit4] 2> 164042 WARN (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] 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> 164054 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 164074 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 164099 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 164099 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 164101 INFO (jetty-launcher-1126-thread-3) [n:127.0.0.1:44419_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node3
[junit4] 2> 164129 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
[junit4] 2> 164131 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 164132 INFO (zkConnectionManagerCallback-1227-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 164132 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 164136 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 164138 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:36445/solr ready
[junit4] 2> 164181 INFO (qtp321768992-1844) [n:127.0.0.1:36499_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=OVERSEERSTATUS&wt=javabin&version=2} status=0 QTime=25
[junit4] 2> 164182 INFO (TEST-MoveReplicaTest.test-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.MoveReplicaTest total_jettys: 4
[junit4] 2> 164185 INFO (OverseerThreadFactory-1163-thread-2-processing-n:127.0.0.1:38133_solr) [n:127.0.0.1:38133_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection MoveReplicaTest_coll_true
[junit4] 2> 164185 INFO (OverseerCollectionConfigSetProcessor-72519384435326984-127.0.0.1:38133_solr-n_0000000000) [n:127.0.0.1:38133_solr ] 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> 164299 INFO (OverseerStateUpdate-72519384435326984-127.0.0.1:38133_solr-n_0000000000) [n:127.0.0.1:38133_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"MoveReplicaTest_coll_true",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"MoveReplicaTest_coll_true_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:44419/solr",
[junit4] 2> "node_name":"127.0.0.1:44419_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 164301 INFO (OverseerStateUpdate-72519384435326984-127.0.0.1:38133_solr-n_0000000000) [n:127.0.0.1:38133_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"MoveReplicaTest_coll_true",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"MoveReplicaTest_coll_true_shard1_replica_t2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:38133/solr",
[junit4] 2> "node_name":"127.0.0.1:38133_solr",
[junit4] 2> "type":"TLOG",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 164304 INFO (OverseerStateUpdate-72519384435326984-127.0.0.1:38133_solr-n_0000000000) [n:127.0.0.1:38133_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"MoveReplicaTest_coll_true",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"MoveReplicaTest_coll_true_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:36499/solr",
[junit4] 2> "node_name":"127.0.0.1:36499_solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 164307 INFO (OverseerStateUpdate-72519384435326984-127.0.0.1:38133_solr-n_0000000000) [n:127.0.0.1:38133_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"MoveReplicaTest_coll_true",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"MoveReplicaTest_coll_true_shard2_replica_t6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:45403/solr",
[junit4] 2> "node_name":"127.0.0.1:45403_solr",
[junit4] 2> "type":"TLOG",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 164511 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard1_replica_n1&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 164511 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard2_replica_t6&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard2&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 164511 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard1_replica_t2&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard1&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 164512 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 164512 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard2_replica_n4&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 164527 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 164529 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 164529 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 164535 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.8.0
[junit4] 2> 164537 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 164551 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 164555 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 164563 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.s.IndexSchema Schema name=cloud-dynamic
[junit4] 2> 164577 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 164577 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaTest_coll_true_shard1_replica_n1' using configuration from configset conf1, trusted=true
[junit4] 2> 164577 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.MoveReplicaTest_coll_true.shard1.replica_n1' (registry 'solr.core.MoveReplicaTest_coll_true.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 164578 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SolrCore [[MoveReplicaTest_coll_true_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node3/MoveReplicaTest_coll_true_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node3/MoveReplicaTest_coll_true_shard1_replica_n1/data/]
[junit4] 2> 164579 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 164579 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaTest_coll_true_shard2_replica_n4' using configuration from configset conf1, trusted=true
[junit4] 2> 164579 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.MoveReplicaTest_coll_true.shard2.replica_n4' (registry 'solr.core.MoveReplicaTest_coll_true.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 164580 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SolrCore [[MoveReplicaTest_coll_true_shard2_replica_n4] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node1/MoveReplicaTest_coll_true_shard2_replica_n4], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node1/MoveReplicaTest_coll_true_shard2_replica_n4/data/]
[junit4] 2> 164587 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 164588 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaTest_coll_true_shard1_replica_t2' using configuration from configset conf1, trusted=true
[junit4] 2> 164588 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.MoveReplicaTest_coll_true.shard1.replica_t2' (registry 'solr.core.MoveReplicaTest_coll_true.shard1.replica_t2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 164588 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.SolrCore [[MoveReplicaTest_coll_true_shard1_replica_t2] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node2/MoveReplicaTest_coll_true_shard1_replica_t2], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node2/MoveReplicaTest_coll_true_shard1_replica_t2/data/]
[junit4] 2> 164591 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.s.IndexSchema Loaded schema cloud-dynamic/1.6 with uniqueid field id
[junit4] 2> 164591 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.CoreContainer Creating SolrCore 'MoveReplicaTest_coll_true_shard2_replica_t6' using configuration from configset conf1, trusted=true
[junit4] 2> 164591 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.MoveReplicaTest_coll_true.shard2.replica_t6' (registry 'solr.core.MoveReplicaTest_coll_true.shard2.replica_t6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@785ec1db
[junit4] 2> 164591 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.SolrCore [[MoveReplicaTest_coll_true_shard2_replica_t6] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node4/MoveReplicaTest_coll_true_shard2_replica_t6], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001/tempDir-001/node4/MoveReplicaTest_coll_true_shard2_replica_t6/data/]
[junit4] 2> 164627 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 164627 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 164628 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 164628 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 164630 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 164631 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 164631 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 164631 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1684013237793718272
[junit4] 2> 164642 INFO (searcherExecutor-1229-thread-1-processing-n:127.0.0.1:44419_solr x:MoveReplicaTest_coll_true_shard1_replica_n1 c:MoveReplicaTest_coll_true s:shard1 r:core_node3) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard1_replica_n1] Registered new searcher autowarm time: 0 ms
[junit4] 2> 164645 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/MoveReplicaTest_coll_true/terms/shard1 to Terms{values={core_node3=0}, version=0}
[junit4] 2> 164645 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/MoveReplicaTest_coll_true/leaders/shard1
[junit4] 2> 164652 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard1: total=2 found=1 timeoute in=14998ms
[junit4] 2> 164662 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 164662 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 164663 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 164663 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 164667 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 164668 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 164669 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 164669 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1684013237833564160
[junit4] 2> 164687 INFO (searcherExecutor-1231-thread-1-processing-n:127.0.0.1:36499_solr x:MoveReplicaTest_coll_true_shard2_replica_n4 c:MoveReplicaTest_coll_true s:shard2 r:core_node7) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard2_replica_n4] Registered new searcher autowarm time: 0 ms
[junit4] 2> 164691 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 164691 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 164693 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 164693 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 164697 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/MoveReplicaTest_coll_true/terms/shard2 to Terms{values={core_node7=0}, version=0}
[junit4] 2> 164697 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/MoveReplicaTest_coll_true/leaders/shard2
[junit4] 2> 164697 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 164697 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 164697 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 164697 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 164698 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 164698 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1684013237863972864
[junit4] 2> 164699 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 164699 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 164701 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 164701 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 164702 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 164702 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1684013237868167168
[junit4] 2> 164703 INFO (searcherExecutor-1233-thread-1-processing-n:127.0.0.1:38133_solr x:MoveReplicaTest_coll_true_shard1_replica_t2 c:MoveReplicaTest_coll_true s:shard1 r:core_node5) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard1_replica_t2] Registered new searcher autowarm time: 0 ms
[junit4] 2> 164703 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoute in=14997ms
[junit4] 2> 164710 INFO (searcherExecutor-1235-thread-1-processing-n:127.0.0.1:45403_solr x:MoveReplicaTest_coll_true_shard2_replica_t6 c:MoveReplicaTest_coll_true s:shard2 r:core_node8) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard2_replica_t6] Registered new searcher autowarm time: 0 ms
[junit4] 2> 164713 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/MoveReplicaTest_coll_true/terms/shard1 to Terms{values={core_node3=0, core_node5=0}, version=1}
[junit4] 2> 164714 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/MoveReplicaTest_coll_true/leaders/shard1
[junit4] 2> 164714 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/MoveReplicaTest_coll_true/terms/shard2 to Terms{values={core_node7=0, core_node8=0}, version=1}
[junit4] 2> 164714 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/MoveReplicaTest_coll_true/leaders/shard2
[junit4] 2> 165153 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 165153 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 165153 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:44419/solr/MoveReplicaTest_coll_true_shard1_replica_n1/
[junit4] 2> 165154 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: core=MoveReplicaTest_coll_true_shard1_replica_n1 url=http://127.0.0.1:44419/solr START replicas=[http://127.0.0.1:38133/solr/MoveReplicaTest_coll_true_shard1_replica_t2/] nUpdates=100
[junit4] 2> 165154 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.u.PeerSync PeerSync: core=MoveReplicaTest_coll_true_shard1_replica_n1 url=http://127.0.0.1:44419/solr DONE. We have no versions. sync failed.
[junit4] 2> 165156 INFO (qtp1895712273-1856) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.S.Request [MoveReplicaTest_coll_true_shard1_replica_t2] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 165157 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 165157 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 165157 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/MoveReplicaTest_coll_true/leaders/shard1/leader after winning as /collections/MoveReplicaTest_coll_true/leader_elect/shard1/election/72519384435326990-core_node3-n_0000000000
[junit4] 2> 165158 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:44419/solr/MoveReplicaTest_coll_true_shard1_replica_n1/ shard1
[junit4] 2> 165205 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 165205 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 165205 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:36499/solr/MoveReplicaTest_coll_true_shard2_replica_n4/
[junit4] 2> 165206 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.PeerSync PeerSync: core=MoveReplicaTest_coll_true_shard2_replica_n4 url=http://127.0.0.1:36499/solr START replicas=[http://127.0.0.1:45403/solr/MoveReplicaTest_coll_true_shard2_replica_t6/] nUpdates=100
[junit4] 2> 165207 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.u.PeerSync PeerSync: core=MoveReplicaTest_coll_true_shard2_replica_n4 url=http://127.0.0.1:36499/solr DONE. We have no versions. sync failed.
[junit4] 2> 165209 INFO (qtp1399244825-1839) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.S.Request [MoveReplicaTest_coll_true_shard2_replica_t6] webapp=/solr path=/get params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 165209 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the next candidate
[junit4] 2> 165209 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 165209 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/MoveReplicaTest_coll_true/leaders/shard2/leader after winning as /collections/MoveReplicaTest_coll_true/leader_elect/shard2/election/72519384435326987-core_node7-n_0000000000
[junit4] 2> 165212 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:36499/solr/MoveReplicaTest_coll_true_shard2_replica_n4/ shard2
[junit4] 2> 165314 INFO (zkCallback-1213-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 165315 INFO (zkCallback-1185-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 165317 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 165320 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node3 x:MoveReplicaTest_coll_true_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 165322 INFO (qtp321768992-1860) [n:127.0.0.1:36499_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node7&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard2_replica_n4&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=809
[junit4] 2> 165323 INFO (qtp1340200513-1852) [n:127.0.0.1:44419_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard1_replica_n1&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=811
[junit4] 2> 165425 INFO (zkCallback-1185-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 165425 INFO (zkCallback-1213-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 165425 INFO (zkCallback-1213-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 165426 INFO (zkCallback-1185-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 165720 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.ZkController MoveReplicaTest_coll_true_shard1_replica_t2 starting background replication from leader
[junit4] 2> 165720 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:01
[junit4] 2> 165723 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 165723 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr c:MoveReplicaTest_coll_true s:shard1 r:core_node5 x:MoveReplicaTest_coll_true_shard1_replica_t2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 165723 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.ZkController MoveReplicaTest_coll_true_shard2_replica_t6 starting background replication from leader
[junit4] 2> 165723 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.ReplicateFromLeader Will start replication from leader with poll interval: 00:00:01
[junit4] 2> 165724 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 165724 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 ms
[junit4] 2> 165728 INFO (indexFetcher-1255-thread-1) [ ] o.a.s.h.IndexFetcher Updated leaderUrl to http://127.0.0.1:36499/solr/MoveReplicaTest_coll_true_shard2_replica_n4/
[junit4] 2> 165728 INFO (qtp1399244825-1834) [n:127.0.0.1:45403_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node8&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard2_replica_t6&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard2&wt=javabin&version=2&replicaType=TLOG} status=0 QTime=1217
[junit4] 2> 165729 INFO (qtp321768992-1844) [n:127.0.0.1:36499_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node7 x:MoveReplicaTest_coll_true_shard2_replica_n4 ] o.a.s.c.S.Request [MoveReplicaTest_coll_true_shard2_replica_n4] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 165729 INFO (indexFetcher-1255-thread-1) [ ] o.a.s.h.IndexFetcher Leader's generation: 1
[junit4] 2> 165729 INFO (indexFetcher-1255-thread-1) [ ] o.a.s.h.IndexFetcher Leader's version: 0
[junit4] 2> 165729 INFO (indexFetcher-1255-thread-1) [ ] o.a.s.h.IndexFetcher Follower's generation: 1
[junit4] 2> 165729 INFO (indexFetcher-1255-thread-1) [ ] o.a.s.h.IndexFetcher Follower's version: 0
[junit4] 2> 165729 INFO (indexFetcher-1255-thread-1) [ ] o.a.s.h.IndexFetcher New index in Leader. Deleting mine...
[junit4] 2> 165733 INFO (qtp1895712273-1854) [n:127.0.0.1:38133_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node5&collection.configName=conf1&newCollection=true&name=MoveReplicaTest_coll_true_shard1_replica_t2&action=CREATE&numShards=2&collection=MoveReplicaTest_coll_true&shard=shard1&wt=javabin&version=2&replicaType=TLOG} status=0 QTime=1221
[junit4] 2> 165735 INFO (searcherExecutor-1235-thread-1-processing-n:127.0.0.1:45403_solr x:MoveReplicaTest_coll_true_shard2_replica_t6 c:MoveReplicaTest_coll_true s:shard2 r:core_node8) [n:127.0.0.1:45403_solr c:MoveReplicaTest_coll_true s:shard2 r:core_node8 x:MoveReplicaTest_coll_true_shard2_replica_t6 ] o.a.s.c.SolrCore [MoveReplicaTest_coll_true_shard2_replica_t6] Registered new searcher autowarm time: 0 ms
[junit4] 2> 165736 INFO (qtp321768992-1846) [n:127.0.0.1:36499_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 165832 INFO (zkCallback-1185-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 165832 INFO (zkCallback-1187-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 165832 INFO (zkCallback-1185-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_true/state.json] for collection [MoveReplicaTest_coll_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 165832 INFO (zkCallback-1155-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/MoveReplicaTest_coll_tr
[...truncated too long message...]
40445)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x101a3ff3e720008.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x101a3ff3e720008, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x101a3ff3e720008, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 189530 INFO (OverseerAutoScalingTriggerThread-72519385674285064-127.0.0.1:40931_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 189530 INFO (zkCallback-1374-thread-4) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 189530 INFO (zkCallback-1356-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 189532 INFO (closeThreadPool-1455-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72519385674285064-127.0.0.1:40931_solr-n_0000000000) closing
[junit4] 2> 189534 INFO (zkCallback-1356-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 189540 INFO (jetty-closer-1440-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node tag=null
[junit4] 2> 189540 INFO (jetty-closer-1440-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@12e0abad: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node/com.codahale.metrics.MetricRegistry@653456d0
[junit4] 2> 189542 INFO (jetty-closer-1440-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm tag=null
[junit4] 2> 189542 INFO (jetty-closer-1440-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@c40adc8: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm/com.codahale.metrics.MetricRegistry@4818eb94
[junit4] 2> 189543 INFO (jetty-closer-1440-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty tag=null
[junit4] 2> 189543 INFO (jetty-closer-1440-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5849db83: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty/com.codahale.metrics.MetricRegistry@540a291d
[junit4] 2> 189543 INFO (jetty-closer-1440-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster tag=null
[junit4] 2> 189624 INFO (jetty-closer-1440-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72519385674285064-127.0.0.1:40931_solr-n_0000000000) closing
[junit4] 2> 189626 INFO (jetty-closer-1440-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@152c7f5e{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:०}
[junit4] 2> 189626 INFO (jetty-closer-1440-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4a73c778{/solr,null,STOPPED}
[junit4] 2> 189626 INFO (jetty-closer-1440-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 189728 INFO (jetty-closer-1440-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@1c0b405d{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:०}
[junit4] 2> 189728 INFO (jetty-closer-1440-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1ccbc403{/solr,null,STOPPED}
[junit4] 2> 189728 INFO (jetty-closer-1440-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 189828 INFO (jetty-closer-1440-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@33cf16b0{HTTP/1.1, (http/1.1, h2c)}{127.0.0.1:०}
[junit4] 2> 189828 INFO (jetty-closer-1440-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2361c2ba{/solr,null,STOPPED}
[junit4] 2> 189828 INFO (jetty-closer-1440-thread-3) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 189829 INFO (TEST-MoveReplicaTest.testFailedMove-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 189830 WARN (TEST-MoveReplicaTest.testFailedMove-seed#[4F9D91938CAF9763]-SendThread(127.0.0.1:40445)) [ ] o.a.z.ClientCnxn An exception was thrown while closing send thread for session 0x101a3ff3e720000.
[junit4] 2> => EndOfStreamException: Unable to read additional data from server sessionid 0x101a3ff3e720000, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77)
[junit4] 2> org.apache.zookeeper.ClientCnxn$EndOfStreamException: Unable to read additional data from server sessionid 0x101a3ff3e720000, likely server has closed socket
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doIO(ClientCnxnSocketNIO.java:77) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350) ~[zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1275) [zookeeper-3.6.2.jar:3.6.2]
[junit4] 2> 190033 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> 6 /solr/collections/MoveReplicaTest_failed_coll_true/terms/shard2
[junit4] 2> 6 /solr/collections/MoveReplicaTest_failed_coll_true/terms/shard1
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 4 /solr/packages.json
[junit4] 2> 4 /solr/security.json
[junit4] 2> 4 /solr/configs/conf1
[junit4] 2> 2 /solr/collections/MoveReplicaTest_failed_coll_true/collectionprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 56 /solr/collections/MoveReplicaTest_failed_coll_true/state.json
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 30 /solr/overseer/queue
[junit4] 2> 22 /solr/live_nodes
[junit4] 2> 15 /solr/overseer/collection-queue-work
[junit4] 2> 10 /solr/collections
[junit4] 2>
[junit4] 2> 190036 INFO (TEST-MoveReplicaTest.testFailedMove-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:40445
[junit4] 2> 190036 INFO (TEST-MoveReplicaTest.testFailedMove-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:40445
[junit4] 2> 190036 INFO (TEST-MoveReplicaTest.testFailedMove-seed#[4F9D91938CAF9763]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 40445
[junit4] 2> 190037 INFO (TEST-MoveReplicaTest.testFailedMove-seed#[4F9D91938CAF9763]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testFailedMove
[junit4] 2> 190037 INFO (TEST-MoveReplicaTest.testFailedMove-seed#[4F9D91938CAF9763]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testFailedMove
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=MoveReplicaTest -Dtests.method=testFailedMove -Dtests.seed=4F9D91938CAF9763 -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=hi-IN -Dtests.timezone=Asia/Dubai -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 11.1s J2 | MoveReplicaTest.testFailedMove <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<100> but was:<56>
[junit4] > at __randomizedtesting.SeedInfo.seed([4F9D91938CAF9763:E55042613B7C42B3]:0)
[junit4] > at org.apache.solr.cloud.MoveReplicaTest.testFailedMove(MoveReplicaTest.java:309)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene/Lucene-Solr-Tests-8.x/solr/build/solr-core/test/J2/temp/solr.cloud.MoveReplicaTest_4F9D91938CAF9763-001
[junit4] 2> Nov 21, 2020 11:09:58 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(Lucene87): {_root_=PostingsFormat(name=MockRandom), id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene84))}, docValues:{}, maxPointsInLeafNode=1235, maxMBSortInHeap=5.920887751814316, sim=Asserting(RandomSimilarity(queryNorm=true): {}), locale=hi-IN, timezone=Asia/Dubai
[junit4] 2> NOTE: Linux 5.4.0-45-generic amd64/Oracle Corporation 1.8.0_252 (64-bit)/cpus=4,threads=1,free=44551576,total=390594560
[junit4] 2> NOTE: All tests run in this JVM: [TestUniqueKeyFieldResource, HdfsRestartWhileUpdatingTest, SystemInfoHandlerTest, TestDFISimilarityFactory, TestOrdValues, ConcurrentCreateRoutedAliasTest, RandomizedTaggerTest, TestPrepRecovery, SolrIndexSearcherTest, BaseCdcrDistributedZkTest, SolrMetricManagerTest, LeaderElectionTest, PrimUtilsTest, TestJsonFacetRefinement, DocValuesMissingTest, QueryElevationComponentTest, SolrShardReporterTest, TestCloudManagedSchema, MoveReplicaTest]
[junit4] Completed [57/921 (1!)] on J2 in 30.77s, 2 tests, 1 failure <<< FAILURES!
[...truncated 53610 lines...]