Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Solaris/349/ Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseParallelGC
2 tests failed. FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication Error Message: [index.20160124023732261, index.properties, replication.properties, index.20160124023717240] expected:<1> but was:<2> Stack Trace: java.lang.AssertionError: [index.20160124023732261, index.properties, replication.properties, index.20160124023717240] expected:<1> but was:<2> at __randomizedtesting.SeedInfo.seed([5C84E66530510DC6:872FE6A335796475]: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.handler.TestReplicationHandler.checkForSingleIndex(TestReplicationHandler.java:820) at org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:787) 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:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) 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:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) 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:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) 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:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) 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) FAILED: org.apache.solr.search.TestRecoveryHdfs.testRemoveOldLogs Error Message: mismatch: '1524184814250360832'!='1524184813477560320' @ versions/[0] Stack Trace: java.lang.RuntimeException: mismatch: '1524184814250360832'!='1524184813477560320' @ versions/[0] at __randomizedtesting.SeedInfo.seed([5C84E66530510DC6:7D1827CEF86B843E]:0) at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:843) at org.apache.solr.SolrTestCaseJ4.assertJQ(SolrTestCaseJ4.java:790) at org.apache.solr.search.TestRecoveryHdfs.testRemoveOldLogs(TestRecoveryHdfs.java:823) 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:497) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) 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:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) 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:46) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) 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:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) 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 9895 lines...] [junit4] Suite: org.apache.solr.handler.TestReplicationHandler [junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/init-core-data-001 [junit4] 2> 1056947 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestDetails [junit4] 2> 1056948 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/collection1 [junit4] 2> 1056952 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 1056954 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3be79128{/solr,null,AVAILABLE} [junit4] 2> 1056956 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.ServerConnector Started ServerConnector@7171f1bd{HTTP/1.1}{127.0.0.1:38412} [junit4] 2> 1056957 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.Server Started @1061159ms [junit4] 2> 1056957 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=38412} [junit4] 2> 1056957 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@659e0bfd [junit4] 2> 1056957 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001' [junit4] 2> 1056957 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1056957 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1056957 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/solr.xml [junit4] 2> 1056962 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/. [junit4] 2> 1056962 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer New CoreContainer 1488476334 [junit4] 2> 1056962 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001] [junit4] 2> 1056962 WARN (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer Couldn't add files from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/lib to classpath: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/lib [junit4] 2> 1056963 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1056964 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1056964 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1056964 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1056965 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1056965 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1056965 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/. [junit4] 2> 1056966 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/} [junit4] 2> 1056966 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/./collection1 [junit4] 2> 1056966 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 1056967 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0 [junit4] 2> 1056967 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1056967 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/collection1' [junit4] 2> 1056968 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1056968 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1056974 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1056976 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1056979 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 1056981 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1056983 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1056985 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/collection1' [junit4] 2> 1056985 INFO (coreLoadExecutor-2675-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/./collection1 [junit4] 2> 1056985 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1056985 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/./collection1/data/] [junit4] 2> 1056985 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1 [junit4] 2> 1056985 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/./collection1/data [junit4] 2> 1056985 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/./collection1/data/index/ [junit4] 2> 1056985 WARN (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1056986 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/./collection1/data/index [junit4] 2> 1056986 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=30, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 1056986 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2bcc406c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7092c62d),segFN=segments_1,generation=1} [junit4] 2> 1056986 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1056987 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/./collection1/data/ [junit4] 2> 1056988 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1056990 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1056991 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1056992 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1056993 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1056995 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1056995 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file [junit4] 2> 1056995 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1056995 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1056995 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1056995 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=37, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=29.1767578125, floorSegmentMB=2.1923828125, forceMergeDeletesPctAllowed=25.429255178163245, segmentsPerTier=20.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5495406372087581 [junit4] 2> 1056996 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2bcc406c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7092c62d),segFN=segments_1,generation=1} [junit4] 2> 1056996 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1056996 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3b8dc8b7[collection1] main] [junit4] 2> 1056996 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/collection1/conf [junit4] 2> 1056996 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/collection1/conf} [junit4] 2> 1056996 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-001/collection1/conf [junit4] 2> 1056996 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 1056996 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl [junit4] 2> 1056996 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 1056997 INFO (searcherExecutor-2676-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3b8dc8b7[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1056997 INFO (coreLoadExecutor-2675-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 1057470 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/collection1 [junit4] 2> 1057473 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 1057475 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7f936ff{/solr,null,AVAILABLE} [junit4] 2> 1057475 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.ServerConnector Started ServerConnector@4191edef{HTTP/1.1}{127.0.0.1:39184} [junit4] 2> 1057475 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.Server Started @1061678ms [junit4] 2> 1057475 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=39184} [junit4] 2> 1057475 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@659e0bfd [junit4] 2> 1057475 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002' [junit4] 2> 1057475 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1057476 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1057476 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/solr.xml [junit4] 2> 1057479 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/. [junit4] 2> 1057479 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer New CoreContainer 1324922267 [junit4] 2> 1057479 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002] [junit4] 2> 1057479 WARN (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer Couldn't add files from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/lib to classpath: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/lib [junit4] 2> 1057480 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1057481 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1057481 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1057481 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1057481 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1057481 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1057482 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/. [junit4] 2> 1057482 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/} [junit4] 2> 1057482 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1 [junit4] 2> 1057483 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 1057483 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0 [junit4] 2> 1057483 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 1057483 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/collection1' [junit4] 2> 1057484 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1057484 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1057489 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 1057491 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1057504 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 1057506 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1057507 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 1057508 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/collection1' [junit4] 2> 1057508 INFO (coreLoadExecutor-2685-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1 [junit4] 2> 1057509 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1057509 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/collection1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/] [junit4] 2> 1057509 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1 [junit4] 2> 1057509 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data [junit4] 2> 1057509 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index/ [junit4] 2> 1057509 WARN (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1057509 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index [junit4] 2> 1057509 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=30, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 1057510 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_1,generation=1} [junit4] 2> 1057510 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1057510 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/ [junit4] 2> 1057511 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1057513 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1057514 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1057514 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1057515 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 1057517 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1057517 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file [junit4] 2> 1057517 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=37, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=29.1767578125, floorSegmentMB=2.1923828125, forceMergeDeletesPctAllowed=25.429255178163245, segmentsPerTier=20.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5495406372087581 [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_1,generation=1} [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1137b0cc[collection1] main] [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/collection1/conf [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/collection1/conf} [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/collection1/conf [junit4] 2> 1057518 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 1057521 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms [junit4] 2> 1057521 INFO (coreLoadExecutor-2685-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 1057521 INFO (searcherExecutor-2686-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1137b0cc[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1057988 INFO (qtp1257872770-8523) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 1057990 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0 [junit4] 2> 1057994 INFO (qtp1257872770-8525) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0 [junit4] 2> 1057994 INFO (qtp514611609-8541) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=2 [junit4] 2> 1057997 INFO (qtp1257872770-8526) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0 [junit4] 2> 1057999 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058001 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2bcc406c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7092c62d),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2bcc406c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7092c62d),segFN=segments_2,generation=2} [junit4] 2> 1058001 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 1058002 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@30ef8022[collection1] main] [junit4] 2> 1058002 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1058002 INFO (searcherExecutor-2676-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@30ef8022[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))} [junit4] 2> 1058002 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 3 [junit4] 2> 1058005 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix [junit4] 2> 1058007 INFO (qtp1257872770-8528) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 1058008 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 2 [junit4] 2> 1058008 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1 [junit4] 2> 1058008 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process [junit4] 2> 1058019 INFO (qtp1257872770-8523) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=2 [junit4] 2> 1058019 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 10 [junit4] 2> 1058020 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636435 [junit4] 2> 1058020 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 1058021 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=39.8037109375, floorSegmentMB=0.2431640625, forceMergeDeletesPctAllowed=26.588955782818836, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1058021 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_1,generation=1} [junit4] 2> 1058022 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1058022 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1058022 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_1,generation=1} [junit4] 2> 1058022 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 1058022 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 1058022 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@72c70f9f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22d94d23) [junit4] 2> 1058024 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058026 INFO (qtp1257872770-8525) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058029 INFO (qtp1257872770-8526) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058031 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_BlockTreeOrds_0.tio&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058033 INFO (qtp1257872770-8528) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_BlockTreeOrds_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058035 INFO (qtp1257872770-8523) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058038 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058047 INFO (qtp1257872770-8525) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058049 INFO (qtp1257872770-8526) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_BlockTreeOrds_0.tipo&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058052 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058052 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1679) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@72c70f9f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@22d94d23) [junit4] 2> 1058054 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=18, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5153099856581583] [junit4] 2> 1058054 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_2,generation=2} [junit4] 2> 1058054 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 1058054 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1058055 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3f834f9f[collection1] main] [junit4] 2> 1058055 INFO (searcherExecutor-2686-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3f834f9f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))} [junit4] 2> 1058055 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636435 [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636435;done=true>>] [junit4] 2> 1058055 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636435 [junit4] 2> 1058055 INFO (qtp514611609-8542) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:38412/solr/collection1/replication&command=fetchindex} status=0 QTime=51 [junit4] 2> 1058078 INFO (qtp1257872770-8528) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0 [junit4] 2> 1058078 INFO (qtp514611609-8543) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=10 [junit4] 2> 1058087 INFO (qtp1257872770-8523) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0 [junit4] 2> 1058089 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058092 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2bcc406c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7092c62d),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2bcc406c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7092c62d),segFN=segments_3,generation=3} [junit4] 2> 1058092 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 1058092 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@535dfd6c[collection1] main] [junit4] 2> 1058092 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1058092 INFO (searcherExecutor-2676-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@535dfd6c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1)))} [junit4] 2> 1058092 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2 [junit4] 2> 1058094 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix [junit4] 2> 1058096 INFO (qtp1257872770-8525) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 1058096 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 3 [junit4] 2> 1058096 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2 [junit4] 2> 1058096 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process [junit4] 2> 1058098 INFO (qtp1257872770-8526) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=0 [junit4] 2> 1058098 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 19 [junit4] 2> 1058098 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636513 [junit4] 2> 1058099 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=39.8037109375, floorSegmentMB=0.2431640625, forceMergeDeletesPctAllowed=26.588955782818836, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_2,generation=2} [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_2,generation=2} [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2 [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@5d6c8a94 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@758133e8) [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_BlockTreeOrds_0.tio because it already exists [junit4] 2> 1058101 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_BlockTreeOrds_0.doc because it already exists [junit4] 2> 1058102 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists [junit4] 2> 1058102 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists [junit4] 2> 1058102 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists [junit4] 2> 1058102 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_BlockTreeOrds_0.tipo because it already exists [junit4] 2> 1058103 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_BlockTreeOrds_0.tipo&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058106 INFO (qtp1257872770-8528) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058110 INFO (qtp1257872770-8523) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058117 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058127 INFO (qtp1257872770-8525) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_BlockTreeOrds_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058130 INFO (qtp1257872770-8526) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058132 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058138 INFO (qtp1257872770-8528) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_BlockTreeOrds_0.tio&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058140 INFO (qtp1257872770-8523) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058142 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058143 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1742) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@5d6c8a94 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@758133e8) [junit4] 2> 1058144 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=18, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5153099856581583] [junit4] 2> 1058145 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_3,generation=3} [junit4] 2> 1058145 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 1058145 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1058146 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@25ef4882[collection1] main] [junit4] 2> 1058146 INFO (searcherExecutor-2686-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@25ef4882[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1)))} [junit4] 2> 1058146 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636513 [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636513;done=true>>] [junit4] 2> 1058146 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636513 [junit4] 2> 1058146 INFO (qtp514611609-8544) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:38412/solr/collection1/replication&command=fetchindex} status=0 QTime=52 [junit4] 2> 1058151 INFO (qtp1257872770-8525) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0 [junit4] 2> 1058152 INFO (qtp514611609-8545) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=3 [junit4] 2> 1058154 INFO (qtp1257872770-8526) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0 [junit4] 2> 1058156 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058157 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=3 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2bcc406c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7092c62d),segFN=segments_2,generation=2} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2bcc406c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7092c62d),segFN=segments_3,generation=3} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@2bcc406c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7092c62d),segFN=segments_4,generation=4} [junit4] 2> 1058157 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 4 [junit4] 2> 1058157 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@36902611[collection1] main] [junit4] 2> 1058157 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1058157 INFO (searcherExecutor-2676-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@36902611[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1) Uninverting(_2(6.0.0):C1)))} [junit4] 2> 1058157 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1 [junit4] 2> 1058159 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix [junit4] 2> 1058161 INFO (qtp1257872770-8528) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 1058162 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 4 [junit4] 2> 1058162 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 3 [junit4] 2> 1058162 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process [junit4] 2> 1058167 INFO (qtp1257872770-8523) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=0 [junit4] 2> 1058168 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 28 [junit4] 2> 1058168 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636583 [junit4] 2> 1058168 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 1058168 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=33, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=39.8037109375, floorSegmentMB=0.2431640625, forceMergeDeletesPctAllowed=26.588955782818836, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_3,generation=3} [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_3,generation=3} [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 3 [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState Rollback old IndexWriter... core=collection1 [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@41a879f1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48f9cda0) [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_BlockTreeOrds_0.tio because it already exists [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_BlockTreeOrds_0.doc because it already exists [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_BlockTreeOrds_0.tipo because it already exists [junit4] 2> 1058169 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1_BlockTreeOrds_0.tipo because it already exists [junit4] 2> 1058170 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists [junit4] 2> 1058170 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists [junit4] 2> 1058170 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists [junit4] 2> 1058170 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1_BlockTreeOrds_0.doc because it already exists [junit4] 2> 1058170 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists [junit4] 2> 1058170 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists [junit4] 2> 1058170 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1_BlockTreeOrds_0.tio because it already exists [junit4] 2> 1058170 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists [junit4] 2> 1058171 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058176 INFO (qtp1257872770-8525) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058178 INFO (qtp1257872770-8526) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2_BlockTreeOrds_0.doc&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058187 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2_BlockTreeOrds_0.tio&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058189 INFO (qtp1257872770-8528) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058192 INFO (qtp1257872770-8523) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058195 INFO (qtp1257872770-8524) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058197 INFO (qtp1257872770-8525) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2_BlockTreeOrds_0.tipo&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058202 INFO (qtp1257872770-8526) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058207 INFO (qtp1257872770-8527) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=segments_4&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0 [junit4] 2> 1058207 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1805) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@41a879f1 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48f9cda0) [junit4] 2> 1058208 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=18, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5153099856581583] [junit4] 2> 1058209 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_3,generation=3} [junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@737e6c0a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c84a66d),segFN=segments_4,generation=4} [junit4] 2> 1058209 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 4 [junit4] 2> 1058209 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 1058210 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@74b479d5[collection1] main] [junit4] 2> 1058210 INFO (searcherExecutor-2686-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@74b479d5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1) Uninverting(_2(6.0.0):C1)))} [junit4] 2> 1058211 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636583 [CachedDir<<refCount=0;path=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636583;done=true>>] [junit4] 2> 1058211 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-002/./collection1/data/index.20160124023636583 [junit4] 2> 1058211 INFO (qtp514611609-8546) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:38412/solr/collection1/replication&command=fetchindex} status=0 QTime=52 [junit4] 2> 1058213 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003/collection1 [junit4] 2> 1058216 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730 [junit4] 2> 1058218 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1ade0b61{/solr,null,AVAILABLE} [junit4] 2> 1058218 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.ServerConnector Started ServerConnector@7ec83fc5{HTTP/1.1}{127.0.0.1:60535} [junit4] 2> 1058218 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.e.j.s.Server Started @1062421ms [junit4] 2> 1058218 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003/collection1/data, hostContext=/solr, hostPort=60535} [junit4] 2> 1058218 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@659e0bfd [junit4] 2> 1058219 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003' [junit4] 2> 1058219 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1058219 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 1058219 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003/solr.xml [junit4] 2> 1058222 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003/. [junit4] 2> 1058222 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer New CoreContainer 1165427555 [junit4] 2> 1058222 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003] [junit4] 2> 1058223 WARN (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer Couldn't add files from /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003/lib to classpath: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003/lib [junit4] 2> 1058223 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 1058223 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1058224 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1058224 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1058224 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 1058224 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 1058225 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003/. [junit4] 2> 1058225 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, configSetProperties=configsetprops.json, transient=false, dataDir=data/} [junit4] 2> 1058225 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Found core collection1 in /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003/./collection1 [junit4] 2> 1058226 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 1058226 INFO (coreLoadExecutor-2699-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5C84E66530510DC6-001/solr-instance-003/collection1' [junit4] 2> 1058227 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[5C84E66530510DC6]) [ ] o.a.s.s.SolrDispatchFilter user.dir=/export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J0 [junit4] 2> 1058228 INFO (TEST-TestReplicationHandler.do [...truncated too long message...] rol$StatementRunner.run(ThreadLeakControl.java:367) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> Caused by: java.lang.NullPointerException [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198) [junit4] 2> at org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291) [junit4] 2> at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223) [junit4] 2> ... 54 more [junit4] 2> 2844285 INFO (SUITE-TestRecoveryHdfs-seed#[5C84E66530510DC6]-worker) [ x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build/solr-core/test/J1/temp/solr.search.TestRecoveryHdfs_5C84E66530510DC6-001 [junit4] 2> Jan 23, 2016 7:06:22 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 2 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {_version_=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))), val_i=PostingsFormat(name=Memory doPackFST= true), id=PostingsFormat(name=Memory doPackFST= true)}, docValues:{}, sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=es, timezone=Pacific/Guam [junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_66 (64-bit)/cpus=3,threads=2,free=239807816,total=467664896 [junit4] 2> NOTE: All tests run in this JVM: [BadIndexSchemaTest, OpenCloseCoreStressTest, QueryParsingTest, TestFoldingMultitermQuery, TestRestoreCore, TestCopyFieldCollectionResource, OutputWriterTest, DataDrivenBlockJoinTest, TestSolrQueryParser, TestStandardQParsers, TestSolrCloudWithKerberosAlt, CopyFieldTest, TestJettySolrRunner, SolrInfoMBeanTest, SpellCheckCollatorTest, StatsComponentTest, TestManagedSchemaFieldTypeResource, SortByFunctionTest, TestValueSourceCache, DistribJoinFromCollectionTest, TestConfigSets, TestZkChroot, TestPerFieldSimilarity, DistributedFacetPivotWhiteBoxTest, ConvertedLegacyTest, JavabinLoaderTest, TestIndexSearcher, SynonymTokenizerTest, TestPKIAuthenticationPlugin, TestQuerySenderListener, TestFieldCollectionResource, TestMiniSolrCloudCluster, TestFiltering, TestPerFieldSimilarityWithDefaultOverride, TestReplicaProperties, SignatureUpdateProcessorFactoryTest, SharedFSAutoReplicaFailoverTest, DistributedFacetPivotSmallAdvancedTest, OverseerCollectionConfigSetProcessorTest, TermVectorComponentDistributedTest, ZkSolrClientTest, ZkStateReaderTest, TestCollectionAPI, BasicFunctionalityTest, TestDownShardTolerantSearch, BasicDistributedZk2Test, TestUtils, IndexSchemaRuntimeFieldTest, VersionInfoTest, TestExactSharedStatsCache, DirectSolrConnectionTest, WordBreakSolrSpellCheckerTest, TestRawTransformer, HdfsNNFailoverTest, SolrXmlInZkTest, TestDistributedGrouping, ReplicationFactorTest, FileBasedSpellCheckerTest, DebugComponentTest, AliasIntegrationTest, CSVRequestHandlerTest, RecoveryAfterSoftCommitTest, TestSolrDeletionPolicy2, DistributedDebugComponentTest, TestCryptoKeys, TestBlobHandler, AtomicUpdatesTest, ConjunctionSolrSpellCheckerTest, DistributedTermsComponentTest, AnalysisErrorHandlingTest, TestMaxScoreQueryParser, ParsingFieldUpdateProcessorsTest, SuggesterTSTTest, LukeRequestHandlerTest, TestNonDefinedSimilarityFactory, RollingRestartTest, DistanceUnitsTest, OpenExchangeRatesOrgProviderTest, MigrateRouteKeyTest, TestCollationField, TestSolrConfigHandler, ChaosMonkeySafeLeaderTest, UpdateRequestProcessorFactoryTest, HLLSerializationTest, CollectionTooManyReplicasTest, HdfsSyncSliceTest, TestBinaryField, FacetPivotSmallTest, TestLeaderElectionZkExpiry, LeaderElectionIntegrationTest, TestReload, FieldAnalysisRequestHandlerTest, SparseHLLTest, TestCollationFieldDocValues, SolrCmdDistributorTest, TestStressRecovery, TestTrieFacet, FullSolrCloudDistribCmdsTest, TestDefaultStatsCache, OverseerStatusTest, TestQueryWrapperFilter, TestBlendedInfixSuggestions, TestSolrConfigHandlerCloud, TermVectorComponentTest, StressHdfsTest, LeaderInitiatedRecoveryOnCommitTest, TestConfigSetsAPIExclusivity, SecurityConfHandlerTest, ConcurrentDeleteAndCreateCollectionTest, HdfsUnloadDistributedZkTest, TestInitParams, LoggingHandlerTest, DateMathParserTest, TestFuzzyAnalyzedSuggestions, HdfsLockFactoryTest, CheckHdfsIndexTest, SuggesterWFSTTest, BinaryUpdateRequestHandlerTest, BJQParserTest, NotRequiredUniqueKeyTest, MultiTermTest, TestAtomicUpdateErrorCases, TestRandomFaceting, TestBinaryResponseWriter, TestSha256AuthenticationProvider, RuleEngineTest, TestOrdValues, TestIndexingPerformance, MergeStrategyTest, TestQueryUtils, FieldMutatingUpdateProcessorTest, SearchHandlerTest, TestRealTimeGet, PluginInfoTest, DistributedVersionInfoTest, ResourceLoaderTest, GraphQueryTest, DistanceFunctionTest, DateFieldTest, RAMDirectoryFactoryTest, TestRequestStatusCollectionAPI, AutoCommitTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, TestRecovery, DistributedSpellCheckComponentTest, ZkControllerTest, TestStressReorder, TestJoin, TestRangeQuery, TestCoreContainer, TestSolr4Spatial, SolrCoreTest, SpellCheckComponentTest, QueryElevationComponentTest, PeerSyncTest, TestFunctionQuery, TestLazyCores, TestBadConfig, HighlighterTest, SoftAutoCommitTest, ShowFileRequestHandlerTest, CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest, SolrIndexSplitterTest, TestCoreDiscovery, TestExtendedDismaxParser, SuggesterFSTTest, CoreAdminHandlerTest, DocValuesTest, SuggesterTest, TestTrie, SpatialFilterTest, TestCSVLoader, NoCacheHeaderTest, SolrCoreCheckLockOnStartupTest, TestUpdate, DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest, TestSolrDeletionPolicy1, XsltUpdateRequestHandlerTest, CacheHeaderTest, TestSurroundQueryParser, DisMaxRequestHandlerTest, TestWriterPerf, DirectSolrSpellCheckerTest, TestQueryTypes, TestOmitPositions, PathHierarchyTokenizerFactoryTest, RequiredFieldsTest, SolrPluginUtilsTest, TestCSVResponseWriter, TestAnalyzedSuggestions, TestPHPSerializedResponseWriter, HighlighterConfigTest, TestSolrIndexConfig, ResponseLogComponentTest, TestMergePolicyConfig, TestDocSet, TestSearchPerf, NumericFieldsTest, MinimalSchemaTest, TestConfig, TestSolrCoreProperties, SpellPossibilityIteratorTest, TestCharFilters, TestCodecSupport, EchoParamsTest, TestLMJelinekMercerSimilarityFactory, TestBM25SimilarityFactory, TestFastWriter, TimeZoneUtilsTest, TestFastOutputStream, ScriptEngineTest, URLClassifyProcessorTest, TestFastLRUCache, TestSystemIdResolver, TestSuggestSpellingConverter, SpellingQueryConverterTest, DOMUtilTest, TestSolrJ, TestLRUCache, ZkNodePropsTest, SystemInfoHandlerTest, UUIDFieldTest, FileUtilsTest, CircularListTest, DistributedMLTComponentTest, TestRTGBase, DistributedIntervalFacetingTest, ConnectionReuseTest, BaseCdcrDistributedZkTest, CdcrReplicationHandlerTest, CdcrVersionReplicationTest, CloudExitableDirectoryReaderTest, CollectionsAPIAsyncDistributedZkTest, DeleteLastCustomShardedReplicaTest, DeleteReplicaTest, DistribCursorPagingTest, HttpPartitionTest, SharedFSAutoReplicaFailoverUtilsTest, SimpleCollectionCreateDeleteTest, TestCloudInspectUtil, TestCloudPivotFacet, TestConfigSetsAPI, TestConfigSetsAPIZkFailure, TestExclusionRuleCollectionAccess, TestMiniSolrCloudClusterBase, TestShortCircuitedRequests, TriLevelCompositeIdRoutingTest, VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZkTest, HdfsChaosMonkeySafeLeaderTest, HdfsRecoveryZkTest, HdfsRestartWhileUpdatingTest, CachingDirectoryFactoryTest, DirectoryFactoryTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, QueryResultKeyTest, TestConfigSetImmutable, TestDynamicLoading, TestImplicitCoreProperties, TestNRTOpen, TestReloadAndDeleteDocs, TestSolrDynamicMBean, TestSolrXml, RequestLoggingTest, TestReplicationHandlerBackup, TestReqParamsAPI, TestSolrConfigHandlerConcurrent, DistributedFacetPivotLargeTest, DistributedQueryComponentOptimizationTest, SuggestComponentContextFilterQueryTest, SuggestComponentTest, TestDistributedStatsComponentCardinality, TestCloudManagedSchema, TestManagedSchema, TestSchemaManager, TestUseDocValuesAsStored, TestUseDocValuesAsStored2, AnalyticsQueryTest, RankQueryTest, SortSpecParsingTest, TestAddFieldRealTimeGet, TestComplexPhraseQParserPlugin, TestCustomSort, TestFieldSortValues, TestFilteredDocIdSet, TestHashQParserPlugin, TestMissingGroups, TestNoOpRegenerator, TestRandomCollapseQParserPlugin, TestRecoveryHdfs] [junit4] Completed [531/577 (2!)] on J1 in 124.25s, 11 tests, 1 error, 1 skipped <<< FAILURES! [...truncated 181 lines...] BUILD FAILED /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:675: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:619: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/build.xml:57: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/build.xml:233: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/solr/common-build.xml:524: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/common-build.xml:1415: The following error occurred while executing this line: /export/home/jenkins/workspace/Lucene-Solr-trunk-Solaris/lucene/common-build.xml:972: There were test failures: 577 suites (8 ignored), 2316 tests, 1 error, 1 failure, 85 ignored (70 assumptions) [seed: 5C84E66530510DC6] Total time: 69 minutes 56 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org