You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2018/01/27 04:32:25 UTC
[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build #
1649 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1649/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
3 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.handler.PingRequestHandlerTest
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.handler.PingRequestHandlerTest: 1) Thread[id=27624, name=qtp2011894227-27624, state=TIMED_WAITING, group=TGRP-PingRequestHandlerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE scope at org.apache.solr.handler.PingRequestHandlerTest:
1) Thread[id=27624, name=qtp2011894227-27624, state=TIMED_WAITING, group=TGRP-PingRequestHandlerTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([E141BBE5C606133F]:0)
FAILED: junit.framework.TestSuite.org.apache.solr.handler.PingRequestHandlerTest
Error Message:
There are still zombie threads that couldn't be terminated: 1) Thread[id=27624, name=qtp2011894227-27624, state=TIMED_WAITING, group=TGRP-PingRequestHandlerTest] at sun.misc.Unsafe.park(Native Method) at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215) at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie threads that couldn't be terminated:
1) Thread[id=27624, name=qtp2011894227-27624, state=TIMED_WAITING, group=TGRP-PingRequestHandlerTest]
at sun.misc.Unsafe.park(Native Method)
at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2163)
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.reservedWait(ReservedThreadExecutor.java:308)
at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:373)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708)
at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([E141BBE5C606133F]:0)
FAILED: org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testDistributions
Error Message:
Stack Trace:
java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([DE7272572450C1AC:618D33FDFAAA2130]:0)
at org.junit.Assert.fail(Assert.java:92)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertTrue(Assert.java:54)
at org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testDistributions(StreamExpressionTest.java:6637)
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:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 13151 lines...]
[junit4] Suite: org.apache.solr.handler.PingRequestHandlerTest
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/init-core-data-001
[junit4] 2> 2800035 WARN (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 2800035 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2800037 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 2800041 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2800042 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 2800042 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2800075 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2800098 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 2800203 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2800242 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800246 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800247 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800247 INFO (coreLoadExecutor-9398-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2800248 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib, /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2800279 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2800295 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 2800376 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2800384 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2800384 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800384 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2800384 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/init-core-data-001/]
[junit4] 2> 2800386 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=39.359375, floorSegmentMB=1.8583984375, forceMergeDeletesPctAllowed=1.3254972769926976, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2800429 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2800429 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2800429 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2800429 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2800430 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 2800430 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6da2f132[collection1] main]
[junit4] 2> 2800430 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2800433 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2800447 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2800447 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2800447 INFO (coreLoadExecutor-9398-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1590716858417283072
[junit4] 2> 2800448 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2800448 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2800448 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 2800448 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2800448 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2800448 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2800448 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2800449 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2800449 INFO (searcherExecutor-9399-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6da2f132[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2800450 INFO (SUITE-PingRequestHandlerTest-seed#[E141BBE5C606133F]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 2800454 INFO (TEST-PingRequestHandlerTest.testBadActionRaisesException-seed#[E141BBE5C606133F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testBadActionRaisesException
[junit4] 2> 2800455 INFO (TEST-PingRequestHandlerTest.testBadActionRaisesException-seed#[E141BBE5C606133F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testBadActionRaisesException
[junit4] 2> 2800458 INFO (TEST-PingRequestHandlerTest.testGettingStatus-seed#[E141BBE5C606133F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testGettingStatus
[junit4] 2> 2800460 INFO (TEST-PingRequestHandlerTest.testGettingStatus-seed#[E141BBE5C606133F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testGettingStatus
[junit4] 2> 2800463 INFO (TEST-PingRequestHandlerTest.testEnablingServer-seed#[E141BBE5C606133F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testEnablingServer
[junit4] 2> 2800464 INFO (TEST-PingRequestHandlerTest.testEnablingServer-seed#[E141BBE5C606133F]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 2800464 INFO (TEST-PingRequestHandlerTest.testEnablingServer-seed#[E141BBE5C606133F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testEnablingServer
[junit4] 2> 2800467 INFO (TEST-PingRequestHandlerTest.testDisablingServer-seed#[E141BBE5C606133F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testDisablingServer
[junit4] 2> 2800468 INFO (TEST-PingRequestHandlerTest.testDisablingServer-seed#[E141BBE5C606133F]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={wt=xml} hits=0 status=0 QTime=0
[junit4] 2> 2800468 INFO (TEST-PingRequestHandlerTest.testDisablingServer-seed#[E141BBE5C606133F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testDisablingServer
[junit4] 2> 2800471 INFO (TEST-PingRequestHandlerTest.testPingInClusterWithNoHealthCheck-seed#[E141BBE5C606133F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPingInClusterWithNoHealthCheck
[junit4] 2> 2800472 INFO (TEST-PingRequestHandlerTest.testPingInClusterWithNoHealthCheck-seed#[E141BBE5C606133F]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 5 servers in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001
[junit4] 2> 2800472 INFO (TEST-PingRequestHandlerTest.testPingInClusterWithNoHealthCheck-seed#[E141BBE5C606133F]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2800472 INFO (Thread-4716) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2800472 INFO (Thread-4716) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2800474 ERROR (Thread-4716) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 2800572 INFO (TEST-PingRequestHandlerTest.testPingInClusterWithNoHealthCheck-seed#[E141BBE5C606133F]) [ ] o.a.s.c.ZkTestServer start zk server on port:58347
[junit4] 2> 2800576 INFO (zkConnectionManagerCallback-8555-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800592 INFO (jetty-launcher-8552-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2800592 INFO (jetty-launcher-8552-thread-2) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2800593 INFO (jetty-launcher-8552-thread-4) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2800594 INFO (jetty-launcher-8552-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2800595 INFO (jetty-launcher-8552-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2800595 INFO (jetty-launcher-8552-thread-1) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2800595 INFO (jetty-launcher-8552-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@30829e12{/solr,null,AVAILABLE}
[junit4] 2> 2800596 INFO (jetty-launcher-8552-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4608153f{SSL,[ssl, http/1.1]}{127.0.0.1:46156}
[junit4] 2> 2800596 INFO (jetty-launcher-8552-thread-1) [ ] o.e.j.s.Server Started @2806175ms
[junit4] 2> 2800596 INFO (jetty-launcher-8552-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46156}
[junit4] 2> 2800596 ERROR (jetty-launcher-8552-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2800597 INFO (jetty-launcher-8552-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 2800597 INFO (jetty-launcher-8552-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2800597 INFO (jetty-launcher-8552-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2800597 INFO (jetty-launcher-8552-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-27T04:03:32.697Z
[junit4] 2> 2800595 INFO (jetty-launcher-8552-thread-3) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2800598 INFO (jetty-launcher-8552-thread-5) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 2800599 INFO (jetty-launcher-8552-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2800599 INFO (jetty-launcher-8552-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2800599 INFO (jetty-launcher-8552-thread-3) [ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 2800599 INFO (jetty-launcher-8552-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@66bc6dff{/solr,null,AVAILABLE}
[junit4] 2> 2800608 INFO (jetty-launcher-8552-thread-4) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2800608 INFO (jetty-launcher-8552-thread-4) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2800608 INFO (jetty-launcher-8552-thread-4) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2800608 INFO (jetty-launcher-8552-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@63444bc1{/solr,null,AVAILABLE}
[junit4] 2> 2800609 INFO (jetty-launcher-8552-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@469465c4{SSL,[ssl, http/1.1]}{127.0.0.1:36840}
[junit4] 2> 2800609 INFO (jetty-launcher-8552-thread-4) [ ] o.e.j.s.Server Started @2806188ms
[junit4] 2> 2800609 INFO (jetty-launcher-8552-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=36840}
[junit4] 2> 2800609 ERROR (jetty-launcher-8552-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2800610 INFO (jetty-launcher-8552-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 2800610 INFO (jetty-launcher-8552-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2800610 INFO (jetty-launcher-8552-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2800610 INFO (jetty-launcher-8552-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-27T04:03:32.710Z
[junit4] 2> 2800611 INFO (jetty-launcher-8552-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@ddcce84{SSL,[ssl, http/1.1]}{127.0.0.1:49492}
[junit4] 2> 2800611 INFO (jetty-launcher-8552-thread-3) [ ] o.e.j.s.Server Started @2806190ms
[junit4] 2> 2800611 INFO (jetty-launcher-8552-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=49492}
[junit4] 2> 2800611 ERROR (jetty-launcher-8552-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2800612 INFO (jetty-launcher-8552-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 2800612 INFO (jetty-launcher-8552-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2800612 INFO (jetty-launcher-8552-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2800612 INFO (jetty-launcher-8552-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-27T04:03:32.712Z
[junit4] 2> 2800614 INFO (zkConnectionManagerCallback-8559-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800615 INFO (jetty-launcher-8552-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2800616 INFO (jetty-launcher-8552-thread-5) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2800616 INFO (jetty-launcher-8552-thread-5) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2800616 INFO (jetty-launcher-8552-thread-5) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2800616 INFO (jetty-launcher-8552-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@58f33474{/solr,null,AVAILABLE}
[junit4] 2> 2800616 INFO (jetty-launcher-8552-thread-5) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3cef499a{SSL,[ssl, http/1.1]}{127.0.0.1:60164}
[junit4] 2> 2800617 INFO (jetty-launcher-8552-thread-5) [ ] o.e.j.s.Server Started @2806195ms
[junit4] 2> 2800617 INFO (jetty-launcher-8552-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=60164}
[junit4] 2> 2800617 ERROR (jetty-launcher-8552-thread-5) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2800617 INFO (jetty-launcher-8552-thread-5) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 2800617 INFO (jetty-launcher-8552-thread-5) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2800617 INFO (jetty-launcher-8552-thread-5) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2800617 INFO (jetty-launcher-8552-thread-5) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-27T04:03:32.717Z
[junit4] 2> 2800618 INFO (jetty-launcher-8552-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2800618 INFO (jetty-launcher-8552-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2800618 INFO (jetty-launcher-8552-thread-2) [ ] o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 2800618 INFO (jetty-launcher-8552-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@69b6b234{/solr,null,AVAILABLE}
[junit4] 2> 2800619 INFO (zkConnectionManagerCallback-8557-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800621 INFO (zkConnectionManagerCallback-8563-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800622 INFO (jetty-launcher-8552-thread-5) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2800623 INFO (jetty-launcher-8552-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@44f55853{SSL,[ssl, http/1.1]}{127.0.0.1:52209}
[junit4] 2> 2800623 INFO (jetty-launcher-8552-thread-2) [ ] o.e.j.s.Server Started @2806201ms
[junit4] 2> 2800623 INFO (jetty-launcher-8552-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52209}
[junit4] 2> 2800623 ERROR (jetty-launcher-8552-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2800623 INFO (jetty-launcher-8552-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 2800624 INFO (jetty-launcher-8552-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58347/solr
[junit4] 2> 2800624 INFO (jetty-launcher-8552-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2800624 INFO (jetty-launcher-8552-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2800624 INFO (jetty-launcher-8552-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-01-27T04:03:32.724Z
[junit4] 2> 2800625 INFO (zkConnectionManagerCallback-8561-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800627 INFO (zkConnectionManagerCallback-8567-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800628 INFO (zkConnectionManagerCallback-8569-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800628 INFO (jetty-launcher-8552-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2800628 INFO (jetty-launcher-8552-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2800629 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x16135c8e05d0003, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2800629 INFO (jetty-launcher-8552-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2800635 INFO (zkConnectionManagerCallback-8571-thread-1-processing-n:127.0.0.1:36840_solr) [n:127.0.0.1:36840_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800635 INFO (jetty-launcher-8552-thread-5) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58347/solr
[junit4] 2> 2800637 INFO (jetty-launcher-8552-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58347/solr
[junit4] 2> 2800638 INFO (zkConnectionManagerCallback-8575-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800639 INFO (jetty-launcher-8552-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58347/solr
[junit4] 2> 2800640 INFO (jetty-launcher-8552-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58347/solr
[junit4] 2> 2800642 INFO (zkConnectionManagerCallback-8580-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800643 INFO (zkConnectionManagerCallback-8584-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800644 INFO (zkConnectionManagerCallback-8587-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800645 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x16135c8e05d000a, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 2800645 INFO (zkConnectionManagerCallback-8589-thread-1-processing-n:127.0.0.1:60164_solr) [n:127.0.0.1:60164_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800645 INFO (zkConnectionManagerCallback-8591-thread-1-processing-n:127.0.0.1:46156_solr) [n:127.0.0.1:46156_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800646 INFO (zkConnectionManagerCallback-8593-thread-1-processing-n:127.0.0.1:49492_solr) [n:127.0.0.1:49492_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800647 INFO (zkConnectionManagerCallback-8595-thread-1-processing-n:127.0.0.1:52209_solr) [n:127.0.0.1:52209_solr ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2800833 INFO (jetty-launcher-8552-thread-1) [n:127.0.0.1:46156_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2800833 INFO (jetty-launcher-8552-thread-5) [n:127.0.0.1:60164_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2800834 INFO (jetty-launcher-8552-thread-5) [n:127.0.0.1:60164_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:60164_solr
[junit4] 2> 2800835 INFO (jetty-launcher-8552-thread-1) [n:127.0.0.1:46156_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46156_solr
[junit4] 2> 2800837 INFO (jetty-launcher-8552-thread-5) [n:127.0.0.1:60164_solr ] o.a.s.c.Overseer Overseer (id=99419803652784140-127.0.0.1:60164_solr-n_0000000000) starting
[junit4] 2> 2800838 INFO (zkCallback-8588-thread-1-processing-n:127.0.0.1:60164_solr) [n:127.0.0.1:60164_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2800839 INFO (zkCallback-8590-thread-1-processing-n:127.0.0.1:46156_solr) [n:127.0.0.1:46156_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2800841 INFO (jetty-launcher-8552-thread-2) [n:127.0.0.1:52209_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2800842 INFO (zkCallback-8570-thread-1-processing-n:127.0.0.1:36840_solr) [n:127.0.0.1:36840_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2800843 INFO (jetty-launcher-8552-thread-3) [n:127.0.0.1:49492_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2800843 INFO (jetty-launcher-8552-thread-4) [n:127.0.0.1:36840_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2800846 INFO (jetty-launcher-8552-thread-4) [n:127.0.0.1:36840_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36840_solr
[junit4] 2> 2800848 INFO (jetty-launcher-8552-thread-2) [n:127.0.0.1:52209_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2800853 INFO (jetty-launcher-8552-thread-5) [n:127.0.0.1:60164_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:60164_solr
[junit4] 2> 2800876 INFO (zkCallback-8592-thread-1-processing-n:127.0.0.1:49492_solr) [n:127.0.0.1:49492_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2800876 INFO (zkCallback-8590-thread-1-processing-n:127.0.0.1:46156_solr) [n:127.0.0.1:46156_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 2800886 INFO (zkCallback-8588-thread-1-processing-n:127.0.0.1:60164_solr) [n:127.0.0.1:60164_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 2800887 INFO (zkCallback-8570-thread-1-processing-n:127.0.0.1:36840_solr) [n:127.0.0.1:36840_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 2800887 INFO (zkCallback-8594-thread-1-processing-n:127.0.0.1:52209_solr) [n:127.0.0.1:52209_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 2800911 INFO (zkCallback-8592-thread-2-processing-n:127.0.0.1:49492_solr) [n:127.0.0.1:49492_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2800947 INFO (jetty-launcher-8552-thread-3) [n:127.0.0.1:49492_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2800949 INFO (jetty-launcher-8552-thread-3) [n:127.0.0.1:49492_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49492_solr
[junit4] 2> 2800963 INFO (zkCallback-8594-thread-1-processing-n:127.0.0.1:52209_solr) [n:127.0.0.1:52209_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2800963 INFO (zkCallback-8588-thread-2-processing-n:127.0.0.1:60164_solr) [n:127.0.0.1:60164_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2800963 INFO (zkCallback-8570-thread-1-processing-n:127.0.0.1:36840_solr) [n:127.0.0.1:36840_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2800978 INFO (jetty-launcher-8552-thread-4) [n:127.0.0.1:36840_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36840.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800983 INFO (jetty-launcher-8552-thread-4) [n:127.0.0.1:36840_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36840.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800983 INFO (jetty-launcher-8552-thread-4) [n:127.0.0.1:36840_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36840.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800984 INFO (jetty-launcher-8552-thread-4) [n:127.0.0.1:36840_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node4/.
[junit4] 2> 2800992 INFO (jetty-launcher-8552-thread-1) [n:127.0.0.1:46156_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46156.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800997 INFO (jetty-launcher-8552-thread-1) [n:127.0.0.1:46156_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46156.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800997 INFO (jetty-launcher-8552-thread-1) [n:127.0.0.1:46156_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46156.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2800998 INFO (jetty-launcher-8552-thread-1) [n:127.0.0.1:46156_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node3/.
[junit4] 2> 2800999 INFO (zkCallback-8590-thread-1-processing-n:127.0.0.1:46156_solr) [n:127.0.0.1:46156_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2800999 INFO (zkCallback-8592-thread-2-processing-n:127.0.0.1:49492_solr) [n:127.0.0.1:49492_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2801017 INFO (jetty-launcher-8552-thread-2) [n:127.0.0.1:52209_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52209_solr
[junit4] 2> 2801034 INFO (zkCallback-8594-thread-1-processing-n:127.0.0.1:52209_solr) [n:127.0.0.1:52209_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2801051 INFO (zkCallback-8588-thread-1-processing-n:127.0.0.1:60164_solr) [n:127.0.0.1:60164_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2801059 INFO (zkCallback-8590-thread-1-processing-n:127.0.0.1:46156_solr) [n:127.0.0.1:46156_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2801060 INFO (zkCallback-8592-thread-2-processing-n:127.0.0.1:49492_solr) [n:127.0.0.1:49492_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2801063 INFO (jetty-launcher-8552-thread-5) [n:127.0.0.1:60164_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_60164.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2801069 INFO (jetty-launcher-8552-thread-5) [n:127.0.0.1:60164_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_60164.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2801070 INFO (jetty-launcher-8552-thread-5) [n:127.0.0.1:60164_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_60164.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2801071 INFO (jetty-launcher-8552-thread-5) [n:127.0.0.1:60164_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node5/.
[junit4] 2> 2801072 INFO (zkCallback-8570-thread-1-processing-n:127.0.0.1:36840_solr) [n:127.0.0.1:36840_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2801098 INFO (jetty-launcher-8552-thread-3) [n:127.0.0.1:49492_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49492.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2801107 INFO (jetty-launcher-8552-thread-3) [n:127.0.0.1:49492_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49492.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2801107 INFO (jetty-launcher-8552-thread-3) [n:127.0.0.1:49492_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49492.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2801108 INFO (jetty-launcher-8552-thread-3) [n:127.0.0.1:49492_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node2/.
[junit4] 2> 2801233 INFO (jetty-launcher-8552-thread-2) [n:127.0.0.1:52209_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52209.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2801238 INFO (jetty-launcher-8552-thread-2) [n:127.0.0.1:52209_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52209.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2801238 INFO (jetty-launcher-8552-thread-2) [n:127.0.0.1:52209_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52209.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2801238 INFO (jetty-launcher-8552-thread-2) [n:127.0.0.1:52209_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node1/.
[junit4] 2> 2801274 INFO (zkConnectionManagerCallback-8607-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2801278 INFO (zkConnectionManagerCallback-8610-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2802166 INFO (zkConnectionManagerCallback-8613-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2802168 INFO (TEST-PingRequestHandlerTest.testPingInClusterWithNoHealthCheck-seed#[E141BBE5C606133F]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 2802170 INFO (TEST-PingRequestHandlerTest.testPingInClusterWithNoHealthCheck-seed#[E141BBE5C606133F]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58347/solr ready
[junit4] 2> 2802212 INFO (qtp1946127635-27663) [n:127.0.0.1:60164_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=2&collection.configName=solrCloudCollectionConfig&name=testSolrCloudCollection&nrtReplicas=2&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2802216 INFO (OverseerThreadFactory-9428-thread-1-processing-n:127.0.0.1:60164_solr) [n:127.0.0.1:60164_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testSolrCloudCollection
[junit4] 2> 2802332 INFO (OverseerStateUpdate-99419803652784140-127.0.0.1:60164_solr-n_0000000000) [n:127.0.0.1:60164_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSolrCloudCollection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testSolrCloudCollection_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:49492/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2802340 INFO (OverseerStateUpdate-99419803652784140-127.0.0.1:60164_solr-n_0000000000) [n:127.0.0.1:60164_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSolrCloudCollection",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"testSolrCloudCollection_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:52209/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2802344 INFO (OverseerStateUpdate-99419803652784140-127.0.0.1:60164_solr-n_0000000000) [n:127.0.0.1:60164_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSolrCloudCollection",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"testSolrCloudCollection_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:46156/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2802352 INFO (OverseerStateUpdate-99419803652784140-127.0.0.1:60164_solr-n_0000000000) [n:127.0.0.1:60164_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"testSolrCloudCollection",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"testSolrCloudCollection_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:36840/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2802618 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=solrCloudCollectionConfig&newCollection=true&name=testSolrCloudCollection_shard2_replica_n6&action=CREATE&numShards=2&collection=testSolrCloudCollection&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2802618 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=solrCloudCollectionConfig&newCollection=true&name=testSolrCloudCollection_shard1_replica_n1&action=CREATE&numShards=2&collection=testSolrCloudCollection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2802619 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2802619 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2802621 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=solrCloudCollectionConfig&newCollection=true&name=testSolrCloudCollection_shard1_replica_n2&action=CREATE&numShards=2&collection=testSolrCloudCollection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2802621 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=solrCloudCollectionConfig&newCollection=true&name=testSolrCloudCollection_shard2_replica_n4&action=CREATE&numShards=2&collection=testSolrCloudCollection&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2802622 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2802622 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2802736 INFO (zkCallback-8592-thread-2-processing-n:127.0.0.1:49492_solr) [n:127.0.0.1:49492_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSolrCloudCollection/state.json] for collection [testSolrCloudCollection] has occurred - updating... (live nodes size: [5])
[junit4] 2> 2802736 INFO (zkCallback-8592-thread-1-processing-n:127.0.0.1:49492_solr) [n:127.0.0.1:49492_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSolrCloudCollection/state.json] for collection [testSolrCloudCollection] has occurred - updating... (live nodes size: [5])
[junit4] 2> 2802736 INFO (zkCallback-8590-thread-1-processing-n:127.0.0.1:46156_solr) [n:127.0.0.1:46156_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSolrCloudCollection/state.json] for collection [testSolrCloudCollection] has occurred - updating... (live nodes size: [5])
[junit4] 2> 2802736 INFO (zkCallback-8590-thread-2-processing-n:127.0.0.1:46156_solr) [n:127.0.0.1:46156_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSolrCloudCollection/state.json] for collection [testSolrCloudCollection] has occurred - updating... (live nodes size: [5])
[junit4] 2> 2802736 INFO (zkCallback-8594-thread-2-processing-n:127.0.0.1:52209_solr) [n:127.0.0.1:52209_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSolrCloudCollection/state.json] for collection [testSolrCloudCollection] has occurred - updating... (live nodes size: [5])
[junit4] 2> 2802736 INFO (zkCallback-8570-thread-2-processing-n:127.0.0.1:36840_solr) [n:127.0.0.1:36840_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSolrCloudCollection/state.json] for collection [testSolrCloudCollection] has occurred - updating... (live nodes size: [5])
[junit4] 2> 2802736 INFO (zkCallback-8570-thread-1-processing-n:127.0.0.1:36840_solr) [n:127.0.0.1:36840_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSolrCloudCollection/state.json] for collection [testSolrCloudCollection] has occurred - updating... (live nodes size: [5])
[junit4] 2> 2802736 INFO (zkCallback-8594-thread-1-processing-n:127.0.0.1:52209_solr) [n:127.0.0.1:52209_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testSolrCloudCollection/state.json] for collection [testSolrCloudCollection] has occurred - updating... (live nodes size: [5])
[junit4] 2> 2803664 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2803671 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2803673 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2803716 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 2803717 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.s.IndexSchema [testSolrCloudCollection_shard1_replica_n2] Schema name=test
[junit4] 2> 2803758 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.s.IndexSchema [testSolrCloudCollection_shard2_replica_n6] Schema name=test
[junit4] 2> 2803778 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.s.IndexSchema [testSolrCloudCollection_shard2_replica_n4] Schema name=test
[junit4] 2> 2803905 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.s.IndexSchema [testSolrCloudCollection_shard1_replica_n1] Schema name=test
[junit4] 2> 2803965 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2803986 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2803995 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2804009 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.c.CoreContainer Creating SolrCore 'testSolrCloudCollection_shard2_replica_n6' using configuration from collection testSolrCloudCollection, trusted=true
[junit4] 2> 2804010 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_36840.solr.core.testSolrCloudCollection.shard2.replica_n6' (registry 'solr.core.testSolrCloudCollection.shard2.replica_n6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2804010 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2804010 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.c.SolrCore [[testSolrCloudCollection_shard2_replica_n6] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node4/testSolrCloudCollection_shard2_replica_n6], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node4/./testSolrCloudCollection_shard2_replica_n6/data/]
[junit4] 2> 2804013 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=39.359375, floorSegmentMB=1.8583984375, forceMergeDeletesPctAllowed=1.3254972769926976, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2804027 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2804030 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'testSolrCloudCollection_shard1_replica_n2' using configuration from collection testSolrCloudCollection, trusted=true
[junit4] 2> 2804030 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52209.solr.core.testSolrCloudCollection.shard1.replica_n2' (registry 'solr.core.testSolrCloudCollection.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2804031 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2804031 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.c.SolrCore [[testSolrCloudCollection_shard1_replica_n2] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node1/testSolrCloudCollection_shard1_replica_n2], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node1/./testSolrCloudCollection_shard1_replica_n2/data/]
[junit4] 2> 2804033 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=39.359375, floorSegmentMB=1.8583984375, forceMergeDeletesPctAllowed=1.3254972769926976, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2804069 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.c.CoreContainer Creating SolrCore 'testSolrCloudCollection_shard2_replica_n4' using configuration from collection testSolrCloudCollection, trusted=true
[junit4] 2> 2804069 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46156.solr.core.testSolrCloudCollection.shard2.replica_n4' (registry 'solr.core.testSolrCloudCollection.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2804084 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2804084 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.c.SolrCore [[testSolrCloudCollection_shard2_replica_n4] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node3/testSolrCloudCollection_shard2_replica_n4], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node3/./testSolrCloudCollection_shard2_replica_n4/data/]
[junit4] 2> 2804087 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=39.359375, floorSegmentMB=1.8583984375, forceMergeDeletesPctAllowed=1.3254972769926976, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2804090 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'testSolrCloudCollection_shard1_replica_n1' using configuration from collection testSolrCloudCollection, trusted=true
[junit4] 2> 2804091 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_49492.solr.core.testSolrCloudCollection.shard1.replica_n1' (registry 'solr.core.testSolrCloudCollection.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@160a179e
[junit4] 2> 2804091 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 2804091 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.c.SolrCore [[testSolrCloudCollection_shard1_replica_n1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node2/testSolrCloudCollection_shard1_replica_n1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.PingRequestHandlerTest_E141BBE5C606133F-001/tempDir-001/node2/./testSolrCloudCollection_shard1_replica_n1/data/]
[junit4] 2> 2804094 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=39, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=39.359375, floorSegmentMB=1.8583984375, forceMergeDeletesPctAllowed=1.3254972769926976, segmentsPerTier=37.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2804231 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2804231 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2804232 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2804232 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2804239 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 2804240 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.s.SolrIndexSearcher Opening [Searcher@608b2e5f[testSolrCloudCollection_shard2_replica_n6] main]
[junit4] 2> 2804242 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2804248 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2804248 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2804250 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2804250 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2804252 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 2804252 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@45599f55[testSolrCloudCollection_shard1_replica_n1] main]
[junit4] 2> 2804253 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2804260 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2804263 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2804263 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2804264 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2804264 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2804270 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 2804272 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@66579318[testSolrCloudCollection_shard1_replica_n2] main]
[junit4] 2> 2804272 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2804273 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2804273 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2804276 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2804279 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2804280 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2804284 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=42, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 2804284 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.s.SolrIndexSearcher Opening [Searcher@6eadffd8[testSolrCloudCollection_shard2_replica_n4] main]
[junit4] 2> 2804290 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2804292 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2804300 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 2804318 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2804318 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1590716862476320768
[junit4] 2> 2804319 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2804320 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2804321 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2804321 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 2804321 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2804321 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2804322 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2804322 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2804324 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2804326 INFO (searcherExecutor-9438-thread-1-processing-n:127.0.0.1:36840_solr x:testSolrCloudCollection_shard2_replica_n6 s:shard2 c:testSolrCloudCollection r:core_node8) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.c.SolrCore [testSolrCloudCollection_shard2_replica_n6] Registered new searcher Searcher@608b2e5f[testSolrCloudCollection_shard2_replica_n6] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2804331 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2804332 INFO (searcherExecutor-9440-thread-1-processing-n:127.0.0.1:46156_solr x:testSolrCloudCollection_shard2_replica_n4 s:shard2 c:testSolrCloudCollection r:core_node7) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2804332 INFO (qtp1106985196-27641) [n:127.0.0.1:36840_solr c:testSolrCloudCollection s:shard2 r:core_node8 x:testSolrCloudCollection_shard2_replica_n6] o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for shard shard2: total=2 found=1 timeoutin=9999ms
[junit4] 2> 2804332 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2804331 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2804333 INFO (qtp34070631-27646) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1590716862492049408
[junit4] 2> 2804333 INFO (searcherExecutor-9440-thread-1-processing-n:127.0.0.1:46156_solr x:testSolrCloudCollection_shard2_replica_n4 s:shard2 c:testSolrCloudCollection r:core_node7) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2804333 INFO (qtp1007833257-27633) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1590716862492049408
[junit4] 2> 2804333 INFO (searcherExecutor-9440-thread-1-processing-n:127.0.0.1:46156_solr x:testSolrCloudCollection_shard2_replica_n4 s:shard2 c:testSolrCloudCollection r:core_node7) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2804333 INFO (searcherExecutor-9440-thread-1-processing-n:127.0.0.1:46156_solr x:testSolrCloudCollection_shard2_replica_n4 s:shard2 c:testSolrCloudCollection r:core_node7) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 2804334 INFO (searcherExecutor-9440-thread-1-processing-n:127.0.0.1:46156_solr x:testSolrCloudCollection_shard2_replica_n4 s:shard2 c:testSolrCloudCollection r:core_node7) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2804334 INFO (searcherExecutor-9440-thread-1-processing-n:127.0.0.1:46156_solr x:testSolrCloudCollection_shard2_replica_n4 s:shard2 c:testSolrCloudCollection r:core_node7) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2804335 INFO (searcherExecutor-9441-thread-1-processing-n:127.0.0.1:49492_solr x:testSolrCloudCollection_shard1_replica_n1 s:shard1 c:testSolrCloudCollection r:core_node3) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2804335 INFO (searcherExecutor-9440-thread-1-processing-n:127.0.0.1:46156_solr x:testSolrCloudCollection_shard2_replica_n4 s:shard2 c:testSolrCloudCollection r:core_node7) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 2804335 INFO (searcherExecutor-9441-thread-1-processing-n:127.0.0.1:49492_solr x:testSolrCloudCollection_shard1_replica_n1 s:shard1 c:testSolrCloudCollection r:core_node3) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2804335 INFO (searcherExecutor-9440-thread-1-processing-n:127.0.0.1:46156_solr x:testSolrCloudCollection_shard2_replica_n4 s:shard2 c:testSolrCloudCollection r:core_node7) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 2804335 INFO (searcherExecutor-9439-thread-1-processing-n:127.0.0.1:52209_solr x:testSolrCloudCollection_shard1_replica_n2 s:shard1 c:testSolrCloudCollection r:core_node5) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2804336 INFO (qtp2011894227-27627) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1590716862495195136
[junit4] 2> 2804336 INFO (searcherExecutor-9441-thread-1-processing-n:127.0.0.1:49492_solr x:testSolrCloudCollection_shard1_replica_n1 s:shard1 c:testSolrCloudCollection r:core_node3) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2804336 INFO (searcherExecutor-9441-thread-1-processing-n:127.0.0.1:49492_solr x:testSolrCloudCollection_shard1_replica_n1 s:shard1 c:testSolrCloudCollection r:core_node3) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 2804336 INFO (searcherExecutor-9440-thread-1-processing-n:127.0.0.1:46156_solr x:testSolrCloudCollection_shard2_replica_n4 s:shard2 c:testSolrCloudCollection r:core_node7) [n:127.0.0.1:46156_solr c:testSolrCloudCollection s:shard2 r:core_node7 x:testSolrCloudCollection_shard2_replica_n4] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 2804337 INFO (searcherExecutor-9439-thread-1-processing-n:127.0.0.1:52209_solr x:testSolrCloudCollection_shard1_replica_n2 s:shard1 c:testSolrCloudCollection r:core_node5) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 2804337 INFO (searcherExecutor-9441-thread-1-processing-n:127.0.0.1:49492_solr x:testSolrCloudCollection_shard1_replica_n1 s:shard1 c:testSolrCloudCollection r:core_node3) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 2804337 INFO (searcherExecutor-9439-thread-1-processing-n:127.0.0.1:52209_solr x:testSolrCloudCollection_shard1_replica_n2 s:shard1 c:testSolrCloudCollection r:core_node5) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 2804338 INFO (searcherExecutor-9439-thread-1-processing-n:127.0.0.1:52209_solr x:testSolrCloudCollection_shard1_replica_n2 s:shard1 c:testSolrCloudCollection r:core_node5) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testSolrCloudCollection_shard1_replica_n2] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 2804338 INFO (searcherExecutor-9441-thread-1-processing-n:127.0.0.1:49492_solr x:testSolrCloudCollection_shard1_replica_n1 s:shard1 c:testSolrCloudCollection r:core_node3) [n:127.0.0.1:49492_solr c:testSolrCloudCollection s:shard1 r:core_node3 x:testSolrCloudCollection_shard1_replica_n1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 2804338 INFO (searcherExecutor-9439-thread-1-processing-n:127.0.0.1:52209_solr x:testSolrCloudCollection_shard1_replica_n2 s:shard1 c:testSolrCloudCollection r:core_node5) [n:127.0.0.1:52209_solr c:testSolrCloudCollection s:shard1 r:core_node5 x:testS
[...truncated too long message...]
_replica_n1] o.a.s.c.SolrCore [collection1_shard1_replica_n1] CLOSING SolrCore org.apache.solr.core.SolrCore@2b703a95
[junit4] 2> 341774 INFO (coreCloseExecutor-859-thread-1) [n:127.0.0.1:61765_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard1.replica_n1, tag=728775317
[junit4] 2> 341774 INFO (coreCloseExecutor-859-thread-1) [n:127.0.0.1:61765_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1014dde3: rootName = solr_61765, domain = solr.core.collection1.shard1.replica_n1, service url = null, agent id = null] for registry solr.core.collection1.shard1.replica_n1 / com.codahale.metrics.MetricRegistry@4bbeaf78
[junit4] 2> 341782 INFO (jetty-closer-406-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7c550c22{/solr,null,UNAVAILABLE}
[junit4] 2> 341783 INFO (jetty-closer-406-thread-3) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 341790 INFO (coreCloseExecutor-859-thread-1) [n:127.0.0.1:61765_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard1.leader, tag=728775317
[junit4] 2> 341793 INFO (jetty-closer-406-thread-4) [ ] o.a.s.c.Overseer Overseer (id=99419832600100873-127.0.0.1:61765_solr-n_0000000000) closing
[junit4] 2> 341793 INFO (OverseerStateUpdate-99419832600100873-127.0.0.1:61765_solr-n_0000000000) [n:127.0.0.1:61765_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:61765_solr
[junit4] 2> 341793 WARN (OverseerAutoScalingTriggerThread-99419832600100873-127.0.0.1:61765_solr-n_0000000000) [n:127.0.0.1:61765_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 341808 INFO (jetty-closer-406-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7c5a20d5{/solr,null,UNAVAILABLE}
[junit4] 2> 341810 INFO (jetty-closer-406-thread-4) [ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 341814 ERROR (SUITE-StreamExpressionTest-seed#[DE7272572450C1AC]-worker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 341814 INFO (SUITE-StreamExpressionTest-seed#[DE7272572450C1AC]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:47583 47583
[junit4] 2> 349589 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxnFactory Ignoring unexpected runtime exception
[junit4] 2> java.nio.channels.CancelledKeyException
[junit4] 2> at sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:73)
[junit4] 2> at sun.nio.ch.SelectionKeyImpl.readyOps(SelectionKeyImpl.java:87)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:182)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 349589 INFO (Thread-408) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:47583 47583
[junit4] 2> 349591 WARN (Thread-408) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 100 /solr/aliases.json
[junit4] 2> 100 /solr/clusterprops.json
[junit4] 2> 12 /solr/configs/conf
[junit4] 2> 7 /solr/configs/ml
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 100 /solr/clusterstate.json
[junit4] 2> 38 /solr/collections/destinationCollection/state.json
[junit4] 2> 26 /solr/collections/parallelDestinationCollection1/state.json
[junit4] 2> 20 /solr/collections/parallelDestinationCollection/state.json
[junit4] 2> 12 /solr/collections/collection1/state.json
[junit4] 2> 10 /solr/collections/mainCorpus1/state.json
[junit4] 2> 10 /solr/collections/destination/state.json
[junit4] 2> 10 /solr/collections/destination1/state.json
[junit4] 2> 10 /solr/collections/workQueue1/state.json
[junit4] 2> 10 /solr/collections/workQueue/state.json
[junit4] 2> 10 /solr/collections/uknownCollection/state.json
[junit4] 2> 10 /solr/collections/modelCollection/state.json
[junit4] 2> 10 /solr/collections/checkpointCollection/state.json
[junit4] 2> 10 /solr/collections/mainCorpus/state.json
[junit4] 2> 2 /solr/overseer_elect/election/99419832600100873-127.0.0.1:61765_solr-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 100 /solr/live_nodes
[junit4] 2> 100 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_DE7272572450C1AC-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {expr_s=PostingsFormat(name=Asserting), name_s=PostingsFormat(name=Direct), terms_ss=FSTOrd50, join2_s=FSTOrd50, field_s=PostingsFormat(name=LuceneVarGapFixedInterval), multiDefault=FSTOrd50, subject=FSTOrd50, a1_s=PostingsFormat(name=LuceneVarGapFixedInterval), a2_s=PostingsFormat(name=Asserting), level1_s=PostingsFormat(name=Asserting), body_t=PostingsFormat(name=Direct), s_multi=PostingsFormat(name=Asserting), col_s=PostingsFormat(name=LuceneVarGapFixedInterval), a_ss=FSTOrd50, level2_s=PostingsFormat(name=LuceneVarGapFixedInterval), a_s=PostingsFormat(name=Asserting), tv_text=PostingsFormat(name=LuceneVarGapFixedInterval), term_s=FSTOrd50, a_t=FSTOrd50, text_s=PostingsFormat(name=Asserting), id=PostingsFormat(name=Direct), text=PostingsFormat(name=Asserting), featureSet_s=PostingsFormat(name=LuceneVarGapFixedInterval), checkpoint_ss=PostingsFormat(name=Direct), test_t=PostingsFormat(name=Direct), ident_s=PostingsFormat(name=LuceneVarGapFixedInterval), whitetok=PostingsFormat(name=Direct), side_s=PostingsFormat(name=Direct)}, docValues:{expr_s=DocValuesFormat(name=Direct), name_s=DocValuesFormat(name=Lucene70), iteration_i=DocValuesFormat(name=Lucene70), terms_ss=DocValuesFormat(name=Asserting), join2_s=DocValuesFormat(name=Asserting), multiDefault=DocValuesFormat(name=Asserting), a_f=DocValuesFormat(name=Lucene70), intDefault=DocValuesFormat(name=Lucene70), a2_s=DocValuesFormat(name=Direct), falseNegative_i=DocValuesFormat(name=Lucene70), a_i=DocValuesFormat(name=Lucene70), level1_s=DocValuesFormat(name=Direct), a_s=DocValuesFormat(name=Direct), id=DocValuesFormat(name=Lucene70), alpha_d=DocValuesFormat(name=Lucene70), i_multi=DocValuesFormat(name=Lucene70), idf_d=DocValuesFormat(name=Lucene70), b_ls=DocValuesFormat(name=Lucene70), checkpoint_ss=DocValuesFormat(name=Lucene70), ident_s=DocValuesFormat(name=Lucene70), order_i=DocValuesFormat(name=Asserting), error_d=DocValuesFormat(name=Direct), side_s=DocValuesFormat(name=Lucene70), truePositive_i=DocValuesFormat(name=Direct), miles_i=DocValuesFormat(name=Lucene70), field_s=DocValuesFormat(name=Lucene70), price_f=DocValuesFormat(name=Asserting), a1_s=DocValuesFormat(name=Lucene70), join1_i=DocValuesFormat(name=Direct), join3_i=DocValuesFormat(name=Lucene70), test_i=DocValuesFormat(name=Asserting), falsePositive_i=DocValuesFormat(name=Lucene70), field_i=DocValuesFormat(name=Asserting), s_multi=DocValuesFormat(name=Direct), col_s=DocValuesFormat(name=Lucene70), a_ss=DocValuesFormat(name=Asserting), level2_s=DocValuesFormat(name=Lucene70), score_f=DocValuesFormat(name=Direct), term_s=DocValuesFormat(name=Asserting), text_s=DocValuesFormat(name=Direct), timestamp=DocValuesFormat(name=Asserting), idfs_ds=DocValuesFormat(name=Asserting), featureSet_s=DocValuesFormat(name=Lucene70), weights_ds=DocValuesFormat(name=Lucene70), trueNegative_i=DocValuesFormat(name=Direct), index_i=DocValuesFormat(name=Lucene70), test_dt=DocValuesFormat(name=Direct), out_i=DocValuesFormat(name=Lucene70), _version_=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=667, maxMBSortInHeap=7.0409295865828065, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@4ab82fc9), locale=ca-ES, timezone=Asia/Tomsk
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_152 (64-bit)/cpus=3,threads=1,free=80854272,total=237342720
[junit4] 2> NOTE: All tests run in this JVM: [ArcTangentEvaluatorTest, NaturalLogEvaluatorTest, TestNamedListCodec, TestSolrJErrorHandling, DocumentAnalysisResponseTest, CorrelationEvaluatorTest, QueryResponseTest, LargeVolumeEmbeddedTest, GreaterThanEqualToEvaluatorTest, SolrZkClientTest, CloudSolrClientTest, StreamExpressionToExplanationTest, TestFastInputStream, SolrExampleJettyTest, RoundEvaluatorTest, SolrSchemalessExampleTest, EqualToEvaluatorTest, HyperbolicCosineEvaluatorTest, StreamExpressionParserTest, LessThanEqualToEvaluatorTest, OrEvaluatorTest, SolrQueryTest, AnlysisResponseBaseTest, CoalesceEvaluatorTest, JDBCStreamTest, SolrParamTest, SolrExampleBinaryTest, ModuloEvaluatorTest, LargeVolumeJettyTest, SolrExampleStreamingBinaryTest, ConcurrentUpdateSolrClientTest, CommonParamsTest, RawValueEvaluatorTest, SolrExceptionTest, SquareRootEvaluatorTest, LargeVolumeBinaryJettyTest, TestBatchUpdate, JettyWebappTest, TestSpellCheckResponse, TestSolrProperties, TermsResponseTest, MergeIndexesEmbeddedTest, TestHash, ModifiableSolrParamsTest, NamedListTest, CollectionAdminRequestRequiredParamsTest, TestLBHttpSolrClient, CloudSolrClientBuilderTest, CloudSolrClientCacheTest, HttpSolrClientConPoolTest, GraphExpressionTest, StreamExpressionTest]
[junit4] Completed [146/146 (1!)] on J1 in 143.89s, 153 tests, 1 failure <<< FAILURES!
[...truncated 47201 lines...]