You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/12/29 01:44:52 UTC
[JENKINS-EA] Lucene-Solr-master-Linux (64bit/jdk-9-ea+147) - Build
# 18642 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18642/
Java: 64bit/jdk-9-ea+147 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.update.SolrCmdDistributorTest.test
Error Message:
[SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=add{,id=(null)}; node=StdNode: https://127.0.0.1:33641//collection1/, SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}; node=StdNode: https://127.0.0.1:33641//collection1/] expected:<0> but was:<2>
Stack Trace:
java.lang.AssertionError: [SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=add{,id=(null)}; node=StdNode: https://127.0.0.1:33641//collection1/, SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}; node=StdNode: https://127.0.0.1:33641//collection1/] expected:<0> but was:<2>
at __randomizedtesting.SeedInfo.seed([D5F1C38D5C3C547B:5DA5FC57F2C03983]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.apache.solr.update.SolrCmdDistributorTest.test(SolrCmdDistributorTest.java:165)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:538)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
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:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:367)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 11049 lines...]
[junit4] Suite: org.apache.solr.update.SolrCmdDistributorTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/init-core-data-001
[junit4] 2> 176130 WARN (SUITE-SolrCmdDistributorTest-seed#[D5F1C38D5C3C547B]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=12 numCloses=12
[junit4] 2> 176131 INFO (SUITE-SolrCmdDistributorTest-seed#[D5F1C38D5C3C547B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
[junit4] 2> 176132 INFO (SUITE-SolrCmdDistributorTest-seed#[D5F1C38D5C3C547B]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 176863 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/control/cores/collection1
[junit4] 2> 176869 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 176870 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@415b561a{/,null,AVAILABLE}
[junit4] 2> 176871 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6cbc11c9{SSL,[ssl, http/1.1]}{127.0.0.1:33641}
[junit4] 2> 176871 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server Started @178795ms
[junit4] 2> 176872 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, hostContext=/, solrconfig=solrconfig-tlog.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/control/data, hostPort=33641, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/control/cores}
[junit4] 2> 176872 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 176872 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0
[junit4] 2> 176872 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 176872 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 176872 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T01:03:43.892745Z
[junit4] 2> 176873 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/control/solr.xml
[junit4] 2> 176890 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/control/cores
[junit4] 2> 176890 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 176892 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 176984 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 177003 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 177124 WARN (coreLoadExecutor-735-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 177126 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 177142 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 177142 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/control/cores/collection1/data/]
[junit4] 2> 177143 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ae500ed
[junit4] 2> 177146 WARN (coreLoadExecutor-735-thread-1) [ ] 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> 177153 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 177153 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 177156 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 177156 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 177157 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@72bfe0e[collection1] main]
[junit4] 2> 177157 WARN (coreLoadExecutor-735-thread-1) [ ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 177157 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 177158 INFO (searcherExecutor-736-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@72bfe0e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 177158 INFO (coreLoadExecutor-735-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555010341230870528
[junit4] 2> 178265 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 178269 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 178270 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@64e15e18{/,null,AVAILABLE}
[junit4] 2> 178271 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@661ab2f1{SSL,[ssl, http/1.1]}{127.0.0.1:38984}
[junit4] 2> 178271 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server Started @180196ms
[junit4] 2> 178272 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, hostContext=/, solrconfig=solrconfig-tlog.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard0/data, hostPort=38984, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard0/cores}
[junit4] 2> 178272 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 178272 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0
[junit4] 2> 178272 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 178272 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 178272 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T01:03:45.292479Z
[junit4] 2> 178273 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard0/solr.xml
[junit4] 2> 178284 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard0/cores
[junit4] 2> 178284 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 178285 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 178337 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 178354 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 178472 WARN (coreLoadExecutor-746-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 178474 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 178495 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 178495 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard0/cores/collection1/data/]
[junit4] 2> 178495 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ae500ed
[junit4] 2> 178499 WARN (coreLoadExecutor-746-thread-1) [ ] 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> 178510 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 178510 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 178513 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 178513 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 178514 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6275678c[collection1] main]
[junit4] 2> 178514 WARN (coreLoadExecutor-746-thread-1) [ ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 178515 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 178515 INFO (searcherExecutor-747-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6275678c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 178516 INFO (coreLoadExecutor-746-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555010342654836736
[junit4] 2> 179717 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard1/cores/collection1
[junit4] 2> 179721 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 179722 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5e029be2{/,null,AVAILABLE}
[junit4] 2> 179722 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7aaf44c9{SSL,[ssl, http/1.1]}{127.0.0.1:39773}
[junit4] 2> 179722 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server Started @181647ms
[junit4] 2> 179723 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, hostContext=/, solrconfig=solrconfig-tlog.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard1/data, hostPort=39773, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard1/cores}
[junit4] 2> 179723 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 179723 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0
[junit4] 2> 179723 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 179723 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 179723 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T01:03:46.743438Z
[junit4] 2> 179724 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard1/solr.xml
[junit4] 2> 179734 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard1/cores
[junit4] 2> 179734 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 179736 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 179849 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 179867 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 179952 WARN (coreLoadExecutor-757-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 179953 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 179969 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 179970 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard1/cores/collection1/data/]
[junit4] 2> 179970 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ae500ed
[junit4] 2> 179974 WARN (coreLoadExecutor-757-thread-1) [ ] 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> 179982 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 179982 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 179985 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 179985 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 179986 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4ee1d6f9[collection1] main]
[junit4] 2> 179986 WARN (coreLoadExecutor-757-thread-1) [ ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 179986 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 179987 INFO (searcherExecutor-758-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4ee1d6f9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 179987 INFO (coreLoadExecutor-757-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555010344197292032
[junit4] 2> 181272 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard2/cores/collection1
[junit4] 2> 181276 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 181299 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2b49959e{/,null,AVAILABLE}
[junit4] 2> 181300 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@52543e6d{SSL,[ssl, http/1.1]}{127.0.0.1:39541}
[junit4] 2> 181300 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server Started @183224ms
[junit4] 2> 181300 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, hostContext=/, solrconfig=solrconfig-tlog.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard2/data, hostPort=39541, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard2/cores}
[junit4] 2> 181300 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 181300 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0
[junit4] 2> 181300 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 181300 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 181300 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T01:03:48.320928Z
[junit4] 2> 181301 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard2/solr.xml
[junit4] 2> 181312 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard2/cores
[junit4] 2> 181312 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 181313 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 181389 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 181400 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 181493 WARN (coreLoadExecutor-768-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 181495 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 181510 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 181511 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard2/cores/collection1/data/]
[junit4] 2> 181511 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ae500ed
[junit4] 2> 181517 WARN (coreLoadExecutor-768-thread-1) [ ] 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> 181530 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 181530 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 181535 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 181535 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 181536 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5c090261[collection1] main]
[junit4] 2> 181537 WARN (coreLoadExecutor-768-thread-1) [ ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 181537 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 181538 INFO (searcherExecutor-769-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5c090261[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 181538 INFO (coreLoadExecutor-768-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555010345823633408
[junit4] 2> 182536 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard3/cores/collection1
[junit4] 2> 182539 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 182540 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5732e2d8{/,null,AVAILABLE}
[junit4] 2> 182541 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5e20b79f{SSL,[ssl, http/1.1]}{127.0.0.1:44323}
[junit4] 2> 182541 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.Server Started @184465ms
[junit4] 2> 182541 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=schema.xml, hostContext=/, solrconfig=solrconfig-tlog.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard3/data, hostPort=44323, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard3/cores}
[junit4] 2> 182541 ERROR (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 182541 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0
[junit4] 2> 182541 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 182541 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 182541 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T01:03:49.561931Z
[junit4] 2> 182542 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard3/solr.xml
[junit4] 2> 182553 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard3/cores
[junit4] 2> 182553 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 182554 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 182612 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 182629 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 182744 WARN (coreLoadExecutor-779-thread-1) [ ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 182746 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 182763 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 182764 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001/tempDir-001/shard3/cores/collection1/data/]
[junit4] 2> 182764 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5ae500ed
[junit4] 2> 182768 WARN (coreLoadExecutor-779-thread-1) [ ] 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> 182776 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 182776 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 182779 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 182779 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 182780 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5de863c1[collection1] main]
[junit4] 2> 182780 WARN (coreLoadExecutor-779-thread-1) [ ] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 182780 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 182781 INFO (searcherExecutor-780-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5de863c1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 182781 INFO (coreLoadExecutor-779-thread-1) [ ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555010347127013376
[junit4] 2> 183138 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 183164 INFO (qtp1474793252-1161) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555010347524423680)} 0 4
[junit4] 2> 183185 INFO (qtp1095648334-1178) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555010347547492352)} 0 2
[junit4] 2> 183205 INFO (qtp851940075-1195) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555010347568463872)} 0 3
[junit4] 2> 183225 INFO (qtp1299677966-1212) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555010347590483968)} 0 2
[junit4] 2> 183243 INFO (qtp1437299363-1229) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555010347608309760)} 0 2
[junit4] 2> 183249 ERROR (updateExecutor-191-thread-1) [ ] o.a.s.u.StreamingSolrClients error
[junit4] 2> java.lang.NullPointerException
[junit4] 2> at org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.timer(InstrumentedHttpRequestExecutor.java:65)
[junit4] 2> at org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.execute(InstrumentedHttpRequestExecutor.java:56)
[junit4] 2> at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
[junit4] 2> at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
[junit4] 2> at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
[junit4] 2> at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] 2> at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
[junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
[junit4] 2> at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient$Runner.sendUpdateStream(ConcurrentUpdateSolrClient.java:323)
[junit4] 2> at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient$Runner.run(ConcurrentUpdateSolrClient.java:186)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
[junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 183255 ERROR (updateExecutor-191-thread-1) [ ] o.a.s.u.SolrCmdDistributor java.lang.NullPointerException
[junit4] 2> at org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.timer(InstrumentedHttpRequestExecutor.java:65)
[junit4] 2> at org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.execute(InstrumentedHttpRequestExecutor.java:56)
[junit4] 2> at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
[junit4] 2> at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
[junit4] 2> at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
[junit4] 2> at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] 2> at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
[junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:532)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
[junit4] 2> at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.request(ConcurrentUpdateSolrClient.java:442)
[junit4] 2> at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
[junit4] 2> at org.apache.solr.update.SolrCmdDistributor.doRequest(SolrCmdDistributor.java:293)
[junit4] 2> at org.apache.solr.update.SolrCmdDistributor.lambda$submit$0(SolrCmdDistributor.java:282)
[junit4] 2> at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] 2> at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:514)
[junit4] 2> at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1161)
[junit4] 2> at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2>
[junit4] 2> 183257 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 183258 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6cbc11c9{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 183258 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=103125189
[junit4] 2> 183258 INFO (coreCloseExecutor-785-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7a1882e
[junit4] 2> 183258 INFO (coreCloseExecutor-785-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 183258 INFO (coreCloseExecutor-785-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2f937915
[junit4] 2> 183263 INFO (coreCloseExecutor-785-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 183263 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 183264 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@415b561a{/,null,UNAVAILABLE}
[junit4] 2> 183265 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@661ab2f1{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 183265 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1013022833
[junit4] 2> 183265 INFO (coreCloseExecutor-787-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7cebd780
[junit4] 2> 183265 INFO (coreCloseExecutor-787-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 183265 INFO (coreCloseExecutor-787-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@50860a69
[junit4] 2> 183272 INFO (coreCloseExecutor-787-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 183272 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 183273 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@64e15e18{/,null,UNAVAILABLE}
[junit4] 2> 183274 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@7aaf44c9{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 183274 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=892071688
[junit4] 2> 183274 INFO (coreCloseExecutor-789-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@592ed10d
[junit4] 2> 183274 INFO (coreCloseExecutor-789-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 183274 INFO (coreCloseExecutor-789-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@198c6a6
[junit4] 2> 183278 INFO (coreCloseExecutor-789-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 183278 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 183279 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5e029be2{/,null,UNAVAILABLE}
[junit4] 2> 183281 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@52543e6d{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 183281 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1764555673
[junit4] 2> 183281 INFO (coreCloseExecutor-791-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@15985e76
[junit4] 2> 183281 INFO (coreCloseExecutor-791-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 183281 INFO (coreCloseExecutor-791-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ce1697d
[junit4] 2> 183285 INFO (coreCloseExecutor-791-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 183285 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 183286 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2b49959e{/,null,UNAVAILABLE}
[junit4] 2> 183287 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5e20b79f{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 183287 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=363671255
[junit4] 2> 183287 INFO (coreCloseExecutor-793-thread-1) [ ] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@30da9f81
[junit4] 2> 183287 INFO (coreCloseExecutor-793-thread-1) [ ] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 183287 INFO (coreCloseExecutor-793-thread-1) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@66365924
[junit4] 2> 183294 INFO (coreCloseExecutor-793-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 183294 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 183295 INFO (TEST-SolrCmdDistributorTest.test-seed#[D5F1C38D5C3C547B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5732e2d8{/,null,UNAVAILABLE}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrCmdDistributorTest -Dtests.method=test -Dtests.seed=D5F1C38D5C3C547B -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=pa-Guru -Dtests.timezone=Etc/Zulu -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 7.17s J1 | SolrCmdDistributorTest.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: [SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=add{,id=(null)}; node=StdNode: https://127.0.0.1:33641//collection1/, SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}; node=StdNode: https://127.0.0.1:33641//collection1/] expected:<0> but was:<2>
[junit4] > at __randomizedtesting.SeedInfo.seed([D5F1C38D5C3C547B:5DA5FC57F2C03983]:0)
[junit4] > at org.apache.solr.update.SolrCmdDistributorTest.test(SolrCmdDistributorTest.java:165)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:538)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 183298 INFO (SUITE-SolrCmdDistributorTest-seed#[D5F1C38D5C3C547B]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_D5F1C38D5C3C547B-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=459, maxMBSortInHeap=7.808390156566379, sim=RandomSimilarity(queryNorm=false): {}, locale=pa-Guru, timezone=Etc/Zulu
[junit4] 2> NOTE: Linux 4.4.0-53-generic amd64/Oracle Corporation 9-ea (64-bit)/cpus=12,threads=1,free=155940792,total=526385152
[junit4] 2> NOTE: All tests run in this JVM: [TestSearchPerf, TestMinMaxOnMultiValuedField, LeaderElectionContextKeyTest, TestExactStatsCache, TestSolrCoreSnapshots, CollectionsAPIAsyncDistributedZkTest, BigEndianAscendingWordDeserializerTest, SchemaVersionSpecificBehaviorTest, QueryParsingTest, SpellCheckCollatorTest, SolrIndexSplitterTest, EnumFieldTest, DOMUtilTest, TestCoreContainer, TestBackupRepositoryFactory, TestFiltering, SimplePostToolTest, ClassificationUpdateProcessorFactoryTest, TestSearcherReuse, ZkSolrClientTest, IndexBasedSpellCheckerTest, IndexSchemaTest, TestBM25SimilarityFactory, TestAuthenticationFramework, SolrCmdDistributorTest]
[junit4] Completed [64/673 (1!)] on J1 in 7.19s, 1 test, 1 failure <<< FAILURES!
[...truncated 53437 lines...]
[JENKINS] Lucene-Solr-master-Linux (64bit/jdk1.8.0_112) - Build #
18643 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18643/
Java: 64bit/jdk1.8.0_112 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.update.SolrCmdDistributorTest.test
Error Message:
[SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=add{,id=(null)}; node=StdNode: https://127.0.0.1:37875//collection1/, SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}; node=StdNode: https://127.0.0.1:37875//collection1/] expected:<0> but was:<2>
Stack Trace:
java.lang.AssertionError: [SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=add{,id=(null)}; node=StdNode: https://127.0.0.1:37875//collection1/, SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}; node=StdNode: https://127.0.0.1:37875//collection1/] expected:<0> but was:<2>
at __randomizedtesting.SeedInfo.seed([A4BF0FC2EDC58CE7:2CEB30184339E11F]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.apache.solr.update.SolrCmdDistributorTest.test(SolrCmdDistributorTest.java:165)
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:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
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:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10726 lines...]
[junit4] Suite: org.apache.solr.update.SolrCmdDistributorTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/init-core-data-001
[junit4] 2> 70346 INFO (SUITE-SolrCmdDistributorTest-seed#[A4BF0FC2EDC58CE7]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 70347 INFO (SUITE-SolrCmdDistributorTest-seed#[A4BF0FC2EDC58CE7]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 70420 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/control/cores/collection1
[junit4] 2> 70422 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 70423 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1183f40{/,null,AVAILABLE}
[junit4] 2> 70424 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4b4defd2{SSL,[ssl, http/1.1]}{127.0.0.1:37875}
[junit4] 2> 70424 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server Started @72363ms
[junit4] 2> 70424 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/control/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=37875, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/control/cores}
[junit4] 2> 70424 ERROR (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 70424 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0
[junit4] 2> 70424 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 70424 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 70424 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T03:55:14.346Z
[junit4] 2> 70425 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/control/solr.xml
[junit4] 2> 70433 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/control/cores
[junit4] 2> 70434 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 70435 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 70456 WARN (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 70457 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 70491 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 70597 WARN (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 70598 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 70610 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 70610 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/control/cores/collection1/data/]
[junit4] 2> 70610 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@10fd736a
[junit4] 2> 70625 WARN (coreLoadExecutor-325-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> 70638 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 70638 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 70639 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 70639 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 70640 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5ab508fe[collection1] main]
[junit4] 2> 70640 WARN (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 70641 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 70642 INFO (searcherExecutor-326-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5ab508fe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 70654 INFO (coreLoadExecutor-325-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555021131495243776
[junit4] 2> 71017 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard0/cores/collection1
[junit4] 2> 71019 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 71020 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@422523c{/,null,AVAILABLE}
[junit4] 2> 71021 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5dab1ba9{SSL,[ssl, http/1.1]}{127.0.0.1:44809}
[junit4] 2> 71021 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server Started @72960ms
[junit4] 2> 71021 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard0/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=44809, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard0/cores}
[junit4] 2> 71021 ERROR (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 71022 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0
[junit4] 2> 71022 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 71022 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 71022 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T03:55:14.944Z
[junit4] 2> 71022 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard0/solr.xml
[junit4] 2> 71031 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard0/cores
[junit4] 2> 71031 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 71032 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 71051 WARN (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 71052 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 71077 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 71151 WARN (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 71153 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 71163 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 71164 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard0/cores/collection1/data/]
[junit4] 2> 71164 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@10fd736a
[junit4] 2> 71171 WARN (coreLoadExecutor-336-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> 71186 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 71186 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 71187 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 71187 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 71188 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@78f880a1[collection1] main]
[junit4] 2> 71188 WARN (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 71188 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 71190 INFO (searcherExecutor-337-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@78f880a1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 71190 INFO (coreLoadExecutor-336-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555021132057280512
[junit4] 2> 71645 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard1/cores/collection1
[junit4] 2> 71648 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 71648 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@8bdb6f2{/,null,AVAILABLE}
[junit4] 2> 71649 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3bec9658{SSL,[ssl, http/1.1]}{127.0.0.1:33617}
[junit4] 2> 71650 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server Started @73589ms
[junit4] 2> 71650 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard1/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=33617, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard1/cores}
[junit4] 2> 71650 ERROR (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 71651 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0
[junit4] 2> 71651 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 71651 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 71651 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T03:55:15.573Z
[junit4] 2> 71651 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard1/solr.xml
[junit4] 2> 71659 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard1/cores
[junit4] 2> 71660 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 71663 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 71701 WARN (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 71702 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 71719 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 71820 WARN (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 71823 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 71834 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 71834 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard1/cores/collection1/data/]
[junit4] 2> 71834 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@10fd736a
[junit4] 2> 71840 WARN (coreLoadExecutor-347-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> 71854 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 71854 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 71854 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 71854 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 71855 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4aad7e57[collection1] main]
[junit4] 2> 71856 WARN (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 71856 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 71857 INFO (searcherExecutor-348-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4aad7e57[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 71857 INFO (coreLoadExecutor-347-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555021132756680704
[junit4] 2> 72245 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard2/cores/collection1
[junit4] 2> 72247 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 72248 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@25cc1011{/,null,AVAILABLE}
[junit4] 2> 72249 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@39dc8b3f{SSL,[ssl, http/1.1]}{127.0.0.1:45565}
[junit4] 2> 72249 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server Started @74188ms
[junit4] 2> 72249 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard2/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=45565, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard2/cores}
[junit4] 2> 72250 ERROR (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 72250 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0
[junit4] 2> 72250 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 72250 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 72250 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T03:55:16.172Z
[junit4] 2> 72250 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard2/solr.xml
[junit4] 2> 72258 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard2/cores
[junit4] 2> 72258 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 72260 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 72279 WARN (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 72279 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 72289 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 72372 WARN (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 72374 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 72381 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 72382 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard2/cores/collection1/data/]
[junit4] 2> 72382 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@10fd736a
[junit4] 2> 72387 WARN (coreLoadExecutor-358-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> 72399 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 72399 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 72399 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 72399 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 72400 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1dc3eb43[collection1] main]
[junit4] 2> 72401 WARN (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 72401 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 72402 INFO (searcherExecutor-359-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1dc3eb43[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 72402 INFO (coreLoadExecutor-358-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555021133328154624
[junit4] 2> 72877 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard3/cores/collection1
[junit4] 2> 72880 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 72899 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2b97f699{/,null,AVAILABLE}
[junit4] 2> 72900 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@64ff1d9d{SSL,[ssl, http/1.1]}{127.0.0.1:42071}
[junit4] 2> 72901 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.Server Started @74840ms
[junit4] 2> 72901 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard3/data, schema=schema.xml, solrconfig=solrconfig-tlog.xml, hostContext=/, hostPort=42071, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard3/cores}
[junit4] 2> 72901 ERROR (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 72902 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0
[junit4] 2> 72902 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 72902 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 72902 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-29T03:55:16.824Z
[junit4] 2> 72903 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard3/solr.xml
[junit4] 2> 72915 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard3/cores
[junit4] 2> 72915 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 72921 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 72962 WARN (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 72963 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 72974 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 73071 WARN (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 73073 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 73084 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
[junit4] 2> 73084 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001/tempDir-001/shard3/cores/collection1/data/]
[junit4] 2> 73084 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@10fd736a
[junit4] 2> 73089 WARN (coreLoadExecutor-369-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> 73100 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 73100 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 73107 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 73107 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 73108 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f8f19e0[collection1] main]
[junit4] 2> 73108 WARN (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 73109 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 73110 INFO (searcherExecutor-370-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1f8f19e0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 73110 INFO (coreLoadExecutor-369-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1555021134070546432
[junit4] 2> 73437 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 73462 INFO (qtp844874314-943) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555021134434402304)} 0 5
[junit4] 2> 73482 INFO (qtp636033415-960) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555021134458519552)} 0 1
[junit4] 2> 73500 INFO (qtp690558131-977) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555021134478442496)} 0 1
[junit4] 2> 73519 INFO (qtp1013630918-994) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555021134498365440)} 0 2
[junit4] 2> 73539 INFO (qtp199998019-1011) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1555021134518288384)} 0 2
[junit4] 2> 73543 ERROR (updateExecutor-153-thread-1-processing-https:////127.0.0.1:37875////collection1) [ ] o.a.s.u.StreamingSolrClients error
[junit4] 2> java.lang.NullPointerException
[junit4] 2> at org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.timer(InstrumentedHttpRequestExecutor.java:65)
[junit4] 2> at org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.execute(InstrumentedHttpRequestExecutor.java:56)
[junit4] 2> at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
[junit4] 2> at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
[junit4] 2> at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
[junit4] 2> at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] 2> at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
[junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
[junit4] 2> at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient$Runner.sendUpdateStream(ConcurrentUpdateSolrClient.java:323)
[junit4] 2> at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient$Runner.run(ConcurrentUpdateSolrClient.java:186)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 73547 ERROR (updateExecutor-153-thread-1) [ ] o.a.s.u.SolrCmdDistributor java.lang.NullPointerException
[junit4] 2> at org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.timer(InstrumentedHttpRequestExecutor.java:65)
[junit4] 2> at org.apache.solr.util.stats.InstrumentedHttpRequestExecutor.execute(InstrumentedHttpRequestExecutor.java:56)
[junit4] 2> at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:271)
[junit4] 2> at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
[junit4] 2> at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
[junit4] 2> at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
[junit4] 2> at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
[junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
[junit4] 2> at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:532)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
[junit4] 2> at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.request(ConcurrentUpdateSolrClient.java:442)
[junit4] 2> at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
[junit4] 2> at org.apache.solr.update.SolrCmdDistributor.doRequest(SolrCmdDistributor.java:293)
[junit4] 2> at org.apache.solr.update.SolrCmdDistributor.lambda$submit$0(SolrCmdDistributor.java:282)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 73548 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 73549 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@4b4defd2{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 73549 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=159435897
[junit4] 2> 73549 INFO (coreCloseExecutor-375-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3019885b
[junit4] 2> 73550 INFO (coreCloseExecutor-375-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 73550 INFO (coreCloseExecutor-375-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@69df746a
[junit4] 2> 73555 INFO (coreCloseExecutor-375-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 73563 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 73564 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1183f40{/,null,UNAVAILABLE}
[junit4] 2> 73565 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5dab1ba9{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 73566 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1567183560
[junit4] 2> 73566 INFO (coreCloseExecutor-377-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@52a68b41
[junit4] 2> 73566 INFO (coreCloseExecutor-377-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 73566 INFO (coreCloseExecutor-377-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@69e395cf
[junit4] 2> 73574 INFO (coreCloseExecutor-377-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 73575 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 73575 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@422523c{/,null,UNAVAILABLE}
[junit4] 2> 73576 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3bec9658{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 73576 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1003153695
[junit4] 2> 73577 INFO (coreCloseExecutor-379-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@48fc4f32
[junit4] 2> 73577 INFO (coreCloseExecutor-379-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 73577 INFO (coreCloseExecutor-379-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@300face6
[junit4] 2> 73582 INFO (coreCloseExecutor-379-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 73582 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 73582 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@8bdb6f2{/,null,UNAVAILABLE}
[junit4] 2> 73583 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@39dc8b3f{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 73583 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=590437829
[junit4] 2> 73584 INFO (coreCloseExecutor-381-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@3f7bcaf
[junit4] 2> 73584 INFO (coreCloseExecutor-381-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 73584 INFO (coreCloseExecutor-381-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5ddbc8fc
[junit4] 2> 73590 INFO (coreCloseExecutor-381-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 73590 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 73590 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@25cc1011{/,null,UNAVAILABLE}
[junit4] 2> 73591 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@64ff1d9d{SSL,[ssl, http/1.1]}{127.0.0.1:0}
[junit4] 2> 73591 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1240956566
[junit4] 2> 73592 INFO (coreCloseExecutor-383-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@322928b1
[junit4] 2> 73592 INFO (coreCloseExecutor-383-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 73592 INFO (coreCloseExecutor-383-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1b5a7cc0
[junit4] 2> 73599 INFO (coreCloseExecutor-383-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 73600 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 73600 INFO (TEST-SolrCmdDistributorTest.test-seed#[A4BF0FC2EDC58CE7]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2b97f699{/,null,UNAVAILABLE}
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrCmdDistributorTest -Dtests.method=test -Dtests.seed=A4BF0FC2EDC58CE7 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sl-SI -Dtests.timezone=Kwajalein -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 3.26s J1 | SolrCmdDistributorTest.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: [SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=add{,id=(null)}; node=StdNode: https://127.0.0.1:37875//collection1/, SolrCmdDistributor$Error: statusCode=-1; exception=java.lang.NullPointerException; req=SolrCmdDistributor$Req: cmd=commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}; node=StdNode: https://127.0.0.1:37875//collection1/] expected:<0> but was:<2>
[junit4] > at __randomizedtesting.SeedInfo.seed([A4BF0FC2EDC58CE7:2CEB30184339E11F]:0)
[junit4] > at org.apache.solr.update.SolrCmdDistributorTest.test(SolrCmdDistributorTest.java:165)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 73604 INFO (SUITE-SolrCmdDistributorTest-seed#[A4BF0FC2EDC58CE7]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.update.SolrCmdDistributorTest_A4BF0FC2EDC58CE7-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=true): {}, locale=sl-SI, timezone=Kwajalein
[junit4] 2> NOTE: Linux 4.4.0-53-generic amd64/Oracle Corporation 1.8.0_112 (64-bit)/cpus=12,threads=1,free=214484488,total=508887040
[junit4] 2> NOTE: All tests run in this JVM: [RecoveryAfterSoftCommitTest, TestQueryTypes, TestMiniSolrCloudClusterSSL, SolrCmdDistributorTest]
[junit4] Completed [26/673 (1!)] on J1 in 3.29s, 1 test, 1 failure <<< FAILURES!
[...truncated 64504 lines...]