You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/07/03 02:56:45 UTC
[JENKINS] Lucene-Solr-NightlyTests-8.1 - Build # 50 - Still
unstable
Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-8.1/50/
1 tests failed.
FAILED: org.apache.solr.update.PeerSyncTest.test
Error Message:
.response[0][id][0]:1!=2
Stack Trace:
junit.framework.AssertionFailedError: .response[0][id][0]:1!=2
at __randomizedtesting.SeedInfo.seed([8221CF0205D372F8:A75F0D8AB2F1F00]:0)
at junit.framework.Assert.fail(Assert.java:57)
at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:999)
at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1026)
at org.apache.solr.BaseDistributedSearchTestCase.queryAndCompare(BaseDistributedSearchTestCase.java:723)
at org.apache.solr.BaseDistributedSearchTestCase.queryAndCompare(BaseDistributedSearchTestCase.java:714)
at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:104)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 14441 lines...]
[junit4] Suite: org.apache.solr.update.PeerSyncTest
[junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/init-core-data-001
[junit4] 2> 1279489 WARN (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3
[junit4] 2> 1279489 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1279491 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 1279491 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 1279492 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 1279492 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 1279493 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1279531 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1279572 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 1279767 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1279872 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1279875 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1fff30db[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1279880 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4102c1e1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1279932 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1279932 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1280019 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280044 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280044 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280050 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1280113 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1280133 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1280250 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1280266 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1280266 INFO (coreLoadExecutor-4867-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@25ed5765
[junit4] 2> 1280267 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/init-core-data-001/]
[junit4] 2> 1280269 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1280285 WARN (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1280349 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1280350 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1280351 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1280351 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1280352 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@4eeb431c
[junit4] 2> 1280353 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@390c13b8[collection1] main]
[junit4] 2> 1280353 WARN (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1280360 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1280360 INFO (coreLoadExecutor-4867-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999537582768128
[junit4] 2> 1280368 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1280390 INFO (searcherExecutor-4868-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@390c13b8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1280614 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/cores/collection1
[junit4] 2> 1280615 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1280616 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1280616 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1280616 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1280617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1280617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1280617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 1280617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@238f1008{/,null,AVAILABLE}
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@24f8dca3{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:37841}
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server Started @1280679ms
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=37841, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/cores}
[junit4] 2> 1280618 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.2
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1280618 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-07-03T01:41:29.536Z
[junit4] 2> 1280619 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/solr.xml
[junit4] 2> 1280623 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1280623 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1280625 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1280737 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1280749 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6e205e95[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1280753 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6cbd235d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1280781 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1280781 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1280813 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280830 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280830 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1280833 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/cores
[junit4] 2> 1280833 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1280834 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1280890 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1280910 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1281351 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1281362 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1281363 INFO (coreLoadExecutor-4881-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@25ed5765
[junit4] 2> 1281363 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/control/cores/collection1/data/]
[junit4] 2> 1281366 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1281375 WARN (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1281457 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1281457 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1281460 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1281460 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1281463 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@891b3db
[junit4] 2> 1281466 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@57c0b567[collection1] main]
[junit4] 2> 1281466 WARN (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1281471 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1281474 INFO (coreLoadExecutor-4881-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999538750881792
[junit4] 2> 1281478 INFO (searcherExecutor-4882-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@57c0b567[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1282163 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 1282164 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1282165 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1282165 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1282165 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1282166 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1282166 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1282166 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1282167 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2aa76dff{/,null,AVAILABLE}
[junit4] 2> 1282167 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@734aec5{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:34449}
[junit4] 2> 1282167 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server Started @1282228ms
[junit4] 2> 1282167 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=34449, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/cores}
[junit4] 2> 1282168 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.2
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-07-03T01:41:31.086Z
[junit4] 2> 1282168 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/solr.xml
[junit4] 2> 1282173 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1282173 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1282175 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1282515 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1282516 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7f9ff24[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1282521 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@24343ce4[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1282549 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1282549 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1282588 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1282612 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1282612 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1282617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/cores
[junit4] 2> 1282617 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1282618 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1282685 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1282721 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1282992 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1283002 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1283003 INFO (coreLoadExecutor-4895-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@25ed5765
[junit4] 2> 1283006 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard0/cores/collection1/data/]
[junit4] 2> 1283010 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1283036 WARN (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1283114 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1283114 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1283116 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1283116 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1283118 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@28da7d6a
[junit4] 2> 1283119 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a4628e7[collection1] main]
[junit4] 2> 1283119 WARN (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1283120 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1283121 INFO (coreLoadExecutor-4895-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999540477886464
[junit4] 2> 1283125 INFO (searcherExecutor-4896-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a4628e7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1283798 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/cores/collection1
[junit4] 2> 1283799 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1283799 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1283799 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1283799 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1283800 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1283800 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1283801 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1283801 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@138c5be5{/,null,AVAILABLE}
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3eb3a9d2{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:36906}
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server Started @1283863ms
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=36906, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/cores}
[junit4] 2> 1283802 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.2
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1283802 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-07-03T01:41:32.720Z
[junit4] 2> 1283803 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/solr.xml
[junit4] 2> 1283807 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1283807 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1283809 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1284016 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1284018 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@50fdaeae[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1284023 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@46615e3b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1284051 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1284051 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1284082 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1284100 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1284100 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1284103 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/cores
[junit4] 2> 1284103 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1284106 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1284144 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1284166 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1284296 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1284305 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1284306 INFO (coreLoadExecutor-4909-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@25ed5765
[junit4] 2> 1284306 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard1/cores/collection1/data/]
[junit4] 2> 1284309 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1284315 WARN (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1284375 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1284375 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1284377 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1284377 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1284378 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@3acb9b58
[junit4] 2> 1284379 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@515e757a[collection1] main]
[junit4] 2> 1284380 WARN (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1284380 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1284380 INFO (coreLoadExecutor-4909-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999541798043648
[junit4] 2> 1284397 INFO (searcherExecutor-4910-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@515e757a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1285070 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/cores/collection1
[junit4] 2> 1285071 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 1285072 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 1285072 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 1285072 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 1285074 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 1285074 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 1285074 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 1285074 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@69cee1f4{/,null,AVAILABLE}
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@53b8c156{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:46016}
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.s.Server Started @1285136ms
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=46016, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/cores}
[junit4] 2> 1285075 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.2
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1285075 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-07-03T01:41:33.993Z
[junit4] 2> 1285076 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/solr.xml
[junit4] 2> 1285080 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 1285080 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 1285082 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 1285392 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 1285393 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@6e7e5fc9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1285398 WARN (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@436cca9a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 1285429 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 1285429 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 1285459 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1285476 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1285476 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@25ed5765
[junit4] 2> 1285479 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/cores
[junit4] 2> 1285479 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1285480 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib, /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 1285561 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.2
[junit4] 2> 1285606 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1285799 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 1285808 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 1285809 INFO (coreLoadExecutor-4923-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@25ed5765
[junit4] 2> 1285812 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncTest_8221CF0205D372F8-001/tempDir-001/shard2/cores/collection1/data/]
[junit4] 2> 1285817 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=83.6640625, floorSegmentMB=1.0732421875, forceMergeDeletesPctAllowed=12.13924894104475, segmentsPerTier=33.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1740443820977954, deletesPctAllowed=35.31786463269985
[junit4] 2> 1285823 WARN (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,attributes = {initParams=a, name=/dump, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1285962 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1285962 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1285964 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1285964 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1285965 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@20ddf8b9
[junit4] 2> 1285966 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5c1ff538[collection1] main]
[junit4] 2> 1285967 WARN (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 1285967 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 1285967 INFO (coreLoadExecutor-4923-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1637999543462133760
[junit4] 2> 1285970 INFO (searcherExecutor-4924-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5c1ff538[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1285981 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 1285987 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[1 (1)]} 0 3
[junit4] 2> 1286006 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:34449/collection1] nUpdates=100
[junit4] 2> 1286043 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3b756e40[collection1] realtime]
[junit4] 2> 1286043 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:32.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286043 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2} status=0 QTime=32
[junit4] 2> 1286045 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:1.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=0, maxInHash=0, versionsHash=0, numVersions=0, numDocs=0, maxDoc=0}
[junit4] 2> 1286045 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= DONE. We have no versions. sync failed.
[junit4] 2> 1286047 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286047 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&fingerprint=true&getVersions=100&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1286047 INFO (qtp329220070-19453) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={qt=/get&getVersions=100&sync=http://127.0.0.1:34449/collection1&wt=javabin&version=2} status=0 QTime=41
[junit4] 2> 1286052 INFO (qtp329220070-19454) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[1 (1)]} 0 3
[junit4] 2> 1286053 INFO (qtp329220070-19455) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:34449/collection1] nUpdates=100
[junit4] 2> 1286053 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286054 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 1286076 INFO (qtp329220070-19455) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1131bbf0[collection1] realtime]
[junit4] 2> 1286076 INFO (qtp329220070-19455) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:22.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286076 INFO (qtp329220070-19455) [ x:collection1] o.a.s.u.PeerSync We are already in sync. No need to do a PeerSync
[junit4] 2> 1286076 INFO (qtp329220070-19455) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={qt=/get&getVersions=100&sync=http://127.0.0.1:34449/collection1&wt=javabin&version=2} status=0 QTime=23
[junit4] 2> 1286077 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1637999543577477120,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1286077 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18b1aea5 commitCommandVersion:1637999543577477120
[junit4] 2> 1286080 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4f19d250[collection1] main]
[junit4] 2> 1286081 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1286083 INFO (searcherExecutor-4896-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4f19d250[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.2):c1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.2, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1562118094939}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
[junit4] 2> 1286083 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 6
[junit4] 2> 1286087 INFO (qtp329220070-19456) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1637999543586914304,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1286087 INFO (qtp329220070-19456) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@41a9f6c2 commitCommandVersion:1637999543586914304
[junit4] 2> 1286119 INFO (qtp329220070-19456) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1cc5d429[collection1] main]
[junit4] 2> 1286119 INFO (qtp329220070-19456) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1286121 INFO (searcherExecutor-4910-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1cc5d429[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.2):c1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.2, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1562118094977}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
[junit4] 2> 1286122 INFO (qtp329220070-19456) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 37
[junit4] 2> 1286123 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 1286137 INFO (qtp329220070-19456) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 1286142 INFO (qtp1399230698-19433) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={update.distrib=FROMLEADER&wt=javabin&version=2}{add=[2 (2)]} 0 3
[junit4] 2> 1286143 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= START replicas=[http://127.0.0.1:34449/collection1] nUpdates=100
[junit4] 2> 1286199 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@702a28a8[collection1] realtime]
[junit4] 2> 1286199 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:55.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286199 INFO (qtp1399230698-19434) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2} status=0 QTime=55
[junit4] 2> 1286200 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=1, maxInHash=1, versionsHash=-5451962507482445012, numVersions=1, numDocs=1, maxDoc=1}
[junit4] 2> 1286202 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4c991e68[collection1] realtime]
[junit4] 2> 1286203 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286203 INFO (qtp1399230698-19435) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={distrib=false&qt=/get&fingerprint=true&getVersions=100&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1286203 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= Received 2 versions from http://127.0.0.1:34449/collection1 fingerprint:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286203 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= Requesting updates from http://127.0.0.1:34449/collection1n=1 versions=2
[junit4] 2> 1286205 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecified=2, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286205 INFO (qtp1399230698-19431) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={getUpdates=2&distrib=false&qt=/get&fingerprint=true&onlyIfActive=false&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1286223 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] {add=[2 (2)]} 0 17
[junit4] 2> 1286243 INFO (qtp329220070-19452) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@225b1ab5[collection1] realtime]
[junit4] 2> 1286244 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.IndexFingerprint IndexFingerprint millis:20.0 result:{maxVersionSpecified=2, maxVersionEncountered=2, maxInHash=2, versionsHash=-1218814014108643565, numVersions=2, numDocs=2, maxDoc=1}
[junit4] 2> 1286244 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync Fingerprint comparison: 0
[junit4] 2> 1286244 INFO (qtp329220070-19452) [ x:collection1] o.a.s.u.PeerSync PeerSync: core=collection1 url= DONE. sync succeeded
[junit4] 2> 1286244 INFO (qtp329220070-19452) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/get params={qt=/get&getVersions=100&sync=http://127.0.0.1:34449/collection1&wt=javabin&version=2} status=0 QTime=101
[junit4] 2> 1286245 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1637999543753637888,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1286255 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@18b1aea5 commitCommandVersion:1637999543753637888
[junit4] 2> 1286270 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@53068224[collection1] main]
[junit4] 2> 1286275 INFO (searcherExecutor-4896-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@53068224[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.2):c1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.2, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1562118094939}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}]) Uninverting(_1(8.1.2):c1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=1.8.0_191, java.vm.version=25.191-b12, lucene.version=8.1.2, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic, timestamp=1562118095068}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
[junit4] 2> 1286275 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1286275 INFO (qtp1399230698-19432) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 30
[junit4] 2> 1286276 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1637999543786143744,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1286277 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@41a9f6c2 commitCommandVersion:1637999543786143744
[junit4] 2> 1286283 INFO (qtp329220070-19453) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@63ab5c2e[collection1] main]
[junit4] 2> 1286284 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1286287 INFO (searcherExecutor-4910-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@63ab5c2e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.1.2):c2:[diagnostics={os=Linux, java.version=1.8.0_191, os.arch=amd64, java.runtime.version=1.8.0_191-b12, source=merge, os.version=4.4.0-137-generic, java.vendor=Oracle Corporation, java.vm.version=25.191-b12, lucene.version=8.1.2, mergeMaxNumSegments=-1, mergeFactor=2, timestamp=1562118095179}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_COMPRESSION}])))}
[junit4] 2> 1286288 INFO (qtp329220070-19453) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 12
[junit4] 2> 1286289 INFO (qtp1399230698-19433) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 1286290 INFO (qtp329220070-19454) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 1286292 ERROR (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.BaseDistributedSearchTestCase Mismatched responses:
[junit4] 2> {responseHeader={status=0,QTime=0},response={numFound=2,start=0,docs=[SolrDocument{id=1, range_facet_l=[1], id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], multiDefault=[muLti-Default], intDefault=42, timestamp=Wed Jul 03 03:41:34 CEST 2019, _version_=1, intDvoDefault=42}, SolrDocument{id=2, range_facet_l=[2], id_i1=2, range_facet_l_dv=[2], range_facet_i_dv=[2], n_ti1=-690635325, n_f1=0.34940243, n_tf1=0.040914476, n_d1=0.089648886088605, n_td1=0.9231459813696291, n_l1=6296583917980809237, n_tl1=-1087821682597930894, n_dt1=Tue Aug 27 12:11:59 CET 47180983, n_tdt1=Sat Mar 03 19:10:42 CET 114208140, multiDefault=[muLti-Default], intDefault=42, timestamp=Wed Jul 03 03:41:35 CEST 2019, _version_=2, intDvoDefault=42}]}}
[junit4] 2> {responseHeader={status=0,QTime=0},response={numFound=2,start=0,docs=[SolrDocument{id=2, range_facet_l=[2], id_i1=2, range_facet_l_dv=[2], range_facet_i_dv=[2], n_ti1=-690635325, n_f1=0.34940243, n_tf1=0.040914476, n_d1=0.089648886088605, n_td1=0.9231459813696291, n_l1=6296583917980809237, n_tl1=-1087821682597930894, n_dt1=Tue Aug 27 12:11:59 CET 47180983, n_tdt1=Sat Mar 03 19:10:42 CET 114208140, multiDefault=[muLti-Default], intDefault=42, timestamp=Wed Jul 03 03:41:35 CEST 2019, _version_=2, intDvoDefault=42}, SolrDocument{id=1, range_facet_l=[1], id_i1=1, range_facet_l_dv=[1], range_facet_i_dv=[1], multiDefault=[muLti-Default], intDefault=42, timestamp=Wed Jul 03 03:41:34 CEST 2019, _version_=1, intDvoDefault=42}]}}
[junit4] 2> 1286293 INFO (TEST-PeerSyncTest.test-seed#[8221CF0205D372F8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 1286303 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1230392284
[junit4] 2> 1286325 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=219235192
[junit4] 2> 1286325 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=744613716
[junit4] 2> 1286341 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=328030472
[junit4] 2> 1286347 INFO (coreCloseExecutor-4929-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@472535de
[junit4] 2> 1286347 INFO (coreCloseExecutor-4929-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=472535de
[junit4] 2> 1286347 INFO (coreCloseExecutor-4929-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3dcd10f5: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1c434ef2
[junit4] 2> 1286357 INFO (coreCloseExecutor-4931-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@229aa3b8
[junit4] 2> 1286358 INFO (coreCloseExecutor-4931-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=229aa3b8
[junit4] 2> 1286358 INFO (coreCloseExecutor-4931-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@71e62c06: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@5807f54c
[junit4] 2> 1286375 INFO (coreCloseExecutor-4930-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7793afa2
[junit4] 2> 1286376 INFO (coreCloseExecutor-4930-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=7793afa2
[junit4] 2> 1286376 INFO (coreCloseExecutor-4930-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3bacf07d: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@3d192e25
[junit4] 2> 1286386 INFO (coreCloseExecutor-4932-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@585de6f2
[junit4] 2> 1286386 INFO (coreCloseExecutor-4932-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=585de6f2
[junit4] 2> 1286386 INFO (coreCloseExecutor-4932-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5a02fe00: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@64f899fd
[junit4] 2> 1286397 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286397 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1bb38055: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@28684452
[junit4] 2> 1286401 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286401 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7d4a9673: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1064ed1a
[junit4] 2> 1286403 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1286403 INFO (closeThreadPool-5229-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6102f09e: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@43bf7cc7
[junit4] 2> 1286406 INFO (closeThreadPool-5229-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@24f8dca3{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 1286407 INFO (closeThreadPool-5229-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@238f1008{/,null,UNAVAILABLE}
[junit4] 2> 1286409 INFO (closeThreadPool-5229-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1286410 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286410 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7f8dda69: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@a1dc9bd
[junit4] 2> 1286413 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286413 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5b660e32: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1064ed1a
[junit4] 2> 1286415 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1286415 INFO (closeThreadPool-5229-thread-6) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@45df24d2: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@43bf7cc7
[junit4] 2> 1286473 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286473 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@29285f40: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@37f918f4
[junit4] 2> 1286476 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286476 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@508d5070: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1064ed1a
[junit4] 2> 1286477 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286477 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@267a9ebf: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@1866e4f
[junit4] 2> 1286485 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1286485 INFO (closeThreadPool-5229-thread-7) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5562654: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@43bf7cc7
[junit4] 2> 1286485 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286485 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@9341034: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@1064ed1a
[junit4] 2> 1286488 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1286488 INFO (closeThreadPool-5229-thread-8) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@49b6b588: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@43bf7cc7
[junit4] 2> 1286523 INFO (closeThreadPool-5229-thread-6) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@734aec5{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 1286551 INFO (closeThreadPool-5229-thread-6) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2aa76dff{/,null,UNAVAILABLE}
[junit4] 2> 1286551 INFO (closeThreadPool-5229-thread-6) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1286554 INFO (closeThreadPool-5229-thread-8) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@53b8c156{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 1286556 INFO (closeThreadPool-5229-thread-8) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@69cee1f4{/,null,UNAVAILABLE}
[junit4] 2> 1286557 INFO (closeThreadPool-5229-thread-8) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 1286563 INFO (closeThreadPool-5229-thread-7) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3eb3a9d2{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 1286564 INFO (closeThreadPool-5229-thread-7) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@138c5be5{/,null,UNAVAILABLE}
[junit4] 2> 1286564 INFO (closeThreadPool-5229-thread-7) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=PeerSyncTest -Dtests.method=test -Dtests.seed=8221CF0205D372F8 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/test-data/enwiki.random.lines.txt -Dtests.locale=da-DK -Dtests.timezone=Europe/Zurich -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 7.08s J2 | PeerSyncTest.test <<<
[junit4] > Throwable #1: junit.framework.AssertionFailedError: .response[0][id][0]:1!=2
[junit4] > at __randomizedtesting.SeedInfo.seed([8221CF0205D372F8:A75F0D8AB2F1F00]:0)
[junit4] > at junit.framework.Assert.fail(Assert.java:57)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareSolrResponses(BaseDistributedSearchTestCase.java:999)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.compareResponses(BaseDistributedSearchTestCase.java:1026)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.queryAndCompare(BaseDistributedSearchTestCase.java:723)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase.queryAndCompare(BaseDistributedSearchTestCase.java:714)
[junit4] > at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:104)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1286572 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1286572 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=199314562
[junit4] 2> 1286581 INFO (coreCloseExecutor-4937-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5ec90710
[junit4] 2> 1286581 INFO (coreCloseExecutor-4937-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=5ec90710
[junit4] 2> 1286581 INFO (coreCloseExecutor-4937-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1c42c1fe: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@616abc19
[junit4] 2> 1286600 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1286600 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@716bcf8f: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@6596b8d4
[junit4] 2> 1286601 INFO (SUITE-PeerSyncTest-seed#[8221CF0205D372F8]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1286601 INFO (SUITE-PeerSyncTest
[...truncated too long message...]
y-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file = /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/null1558271355
[copy] Copying 239 files to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/null1558271355
[delete] Deleting directory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-8.1/checkout/solr/null1558271355
check-working-copy:
[ivy:cachepath] :: resolving dependencies :: #;working@lucene1-us-west
[ivy:cachepath] confs: [default]
[ivy:cachepath] found org.eclipse.jgit#org.eclipse.jgit;5.3.0.201903130848-r in public
[ivy:cachepath] found com.jcraft#jsch;0.1.54 in public
[ivy:cachepath] found com.jcraft#jzlib;1.1.1 in public
[ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] found org.bouncycastle#bcpg-jdk15on;1.60 in public
[ivy:cachepath] found org.bouncycastle#bcprov-jdk15on;1.60 in public
[ivy:cachepath] found org.bouncycastle#bcpkix-jdk15on;1.60 in public
[ivy:cachepath] found org.slf4j#slf4j-nop;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 51ms :: artifacts dl 5ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 9 | 0 | 0 | 0 || 9 | 0 |
---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] Checking working copy status...
-jenkins-base:
BUILD SUCCESSFUL
Total time: 277 minutes 23 seconds
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$ValidateAntFileMask.hasMatch(FilePath.java:2847)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2726)
at hudson.FilePath$ValidateAntFileMask.invoke(FilePath.java:2707)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3086)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene
at hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1072)
at hudson.FilePath.act(FilePath.java:1061)
at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1835)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:3088)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath.act(FilePath.java:1074)
at hudson.FilePath.act(FilePath.java:1061)
at hudson.FilePath.validateAntFileMask(FilePath.java:2705)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1835)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern "**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)