Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/12956/ Java: 64bit/jdk1.9.0-ea-b60 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed. FAILED: org.apache.solr.core.TestArbitraryIndexDir.testLoadNewIndexDir Error Message: Exception during query Stack Trace: java.lang.RuntimeException: Exception during query at __randomizedtesting.SeedInfo.seed([54D327AB3E7DB2DB:BD899C93A0E42273]:0) at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:770) at org.apache.solr.core.TestArbitraryIndexDir.testLoadNewIndexDir(TestArbitraryIndexDir.java:128) 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:502) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) 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:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) 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:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) 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:365) at java.lang.Thread.run(Thread.java:745) Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=*[count(//doc)=1] xml response was: <?xml version="1.0" encoding="UTF-8"?> <response> <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int></lst><result name="response" numFound="0" start="0"></result> </response> request was:q=id:2&qt=standard&start=0&rows=20&version=2.2 at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:763) ... 40 more Build Log: [...truncated 9332 lines...] [junit4] Suite: org.apache.solr.core.TestArbitraryIndexDir [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/init-core-data-001 [junit4] 2> 8325 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) [junit4] 2> 8327 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testLoadNewIndexDir [junit4] 2> 8328 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/' [junit4] 2> 8328 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 8328 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 8344 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 8351 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 8373 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 8374 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/src/test-files/solr/collection1/conf/schema12.xml [junit4] 2> 8382 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema [null] Schema name=test [junit4] 2> 8539 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 8540 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 8541 WARN (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2) [junit4] 2> 8577 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 8594 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 8597 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 8597 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 8597 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'solr/' [junit4] 2> 8614 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.CoreContainer New CoreContainer 1501802353 [junit4] 2> 8614 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=solr/] [junit4] 2> 8614 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.CoreContainer loading shared library: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/solr/lib [junit4] 2> 8615 WARN (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/solr/lib). [junit4] 2> 8636 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 8638 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true [junit4] 2> 8638 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 8638 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 8639 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 8639 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema12.xml, loadOnStartup=true, instanceDir=collection1, collection=collection1, absoluteInstDir=solr/collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001, shard=shard1} [junit4] 2> 8664 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'solr/collection1/' [junit4] 2> 8702 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 8718 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 8743 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 8744 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from solr/collection1/conf/schema12.xml [junit4] 2> 8750 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 8866 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 8867 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 8867 WARN (coreLoadExecutor-60-thread-1) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2) [junit4] 2> 8877 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 8879 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 8880 INFO (coreLoadExecutor-60-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir solr/collection1/ [junit4] 2> 8880 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockFSDirectoryFactory [junit4] 2> 8882 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [solr/collection1/], dataDir=[null] [junit4] 2> 8882 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap No JMX servers found, not exposing Solr information with JMX. [junit4] 2> 8883 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001 [junit4] 2> 8883 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index/ [junit4] 2> 8883 WARN (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index' doesn't exist. Creating new index... [junit4] 2> 8884 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index [junit4] 2> 8884 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=11, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=15.2177734375, floorSegmentMB=1.6455078125, forceMergeDeletesPctAllowed=3.5882207035748834, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 8914 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c83657b),segFN=segments_1,generation=1} [junit4] 2> 8915 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 8915 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/ [junit4] 2> 8917 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 8917 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 8917 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 8917 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 8917 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 8917 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 8918 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 8918 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 8918 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 8918 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 8918 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 8918 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 8920 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 8921 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 8921 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 8922 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 8923 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 8923 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump [junit4] 2> 8924 WARN (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 8924 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 8924 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 8926 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 8926 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0] [junit4] 2> 8930 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c83657b),segFN=segments_1,generation=1} [junit4] 2> 8930 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 8930 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@73ce7dc0[collection1] main [junit4] 2> 8931 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 8931 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 8931 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 8931 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 8946 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 9021 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 9022 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 9022 INFO (coreLoadExecutor-60-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 9022 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 9022 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 9023 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 9023 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 9023 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 9024 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 9024 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 9025 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 2 [junit4] 2> 9025 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 9026 INFO (searcherExecutor-61-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@73ce7dc0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 9094 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 9148 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c83657b),segFN=segments_1,generation=1} [junit4] 2> commit{dir=MockDirectoryWrapper(SimpleFSDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7c83657b),segFN=segments_2,generation=2} [junit4] 2> 9149 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrCore newest commit generation = 2 [junit4] 2> 9150 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrCore New index directory detected: old=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index/ new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index_temp [junit4] 2> 9151 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@b84d0a1[collection1] main [junit4] 2> 9152 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.u.UpdateHandler end_commit_flush [junit4] 2> 9152 INFO (searcherExecutor-61-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@b84d0a1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1)))} [junit4] 2> 9152 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 58 [junit4] 2> 9153 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 'solr/collection1/' [junit4] 2> 9168 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 9174 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0 [junit4] 2> 9197 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 9198 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema Reading Solr Schema from solr/collection1/conf/schema12.xml [junit4] 2> 9202 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 9277 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 9278 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 9278 WARN (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2) [junit4] 2> 9291 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 9293 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 9294 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir solr/collection1/ [junit4] 2> 9295 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [solr/collection1/], dataDir=[/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/] [junit4] 2> 9295 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.JmxMonitoredMap No JMX servers found, not exposing Solr information with JMX. [junit4] 2> 9295 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index_temp [junit4] 2> 9296 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/ [junit4] 2> 9297 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory Found 1 old index directories to clean-up under /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/ [junit4] 2> 9297 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.CachingDirectoryFactory Cannot delete directory /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index as it is still being referenced in the cache! [junit4] 2> 9297 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.DirectoryFactory Delete old index directory /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index failed. [junit4] 2> 9298 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe" [junit4] 2> 9298 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 9298 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 9299 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 9299 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig" [junit4] 2> 9299 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 9299 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 9300 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 9300 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 9300 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 9300 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 9300 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 9304 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 9305 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 9306 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 9307 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 9309 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy [junit4] 2> 9314 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump [junit4] 2> 9315 WARN (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 9315 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 9316 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled [junit4] 2> 9316 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled [junit4] 2> 9318 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@13ed9577[collection1] main [junit4] 2> 9319 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 9319 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage [junit4] 2> 9319 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 9319 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 9321 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 9326 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 9326 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 9326 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.DefaultSolrCoreState Creating new IndexWriter... [junit4] 2> 9327 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.DefaultSolrCoreState Waiting until IndexWriter is unused... core=collection1 [junit4] 2> 9327 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.DefaultSolrCoreState Closing old IndexWriter... core=collection1 [junit4] 2> 9327 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 9327 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 9328 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 9328 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index_temp [junit4] 2> 9328 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=31, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.2506659026906143] [junit4] 2> 9328 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 9329 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 9330 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 9330 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 9330 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=MockDirectoryWrapper(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index_temp lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2d133e30),segFN=segments_1,generation=1} [junit4] 2> 9330 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 9330 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1 [junit4] 2> 9331 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@13ed9577[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1)))} [junit4] 2> 9331 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used. [junit4] 2> 9334 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@32563d84[collection1] main [junit4] 2> 9334 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.CoreContainer replacing core: collection1 [junit4] 2> 9335 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7de1c3ea [junit4] 2> 9335 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.u.UpdateHandler closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4] 2> 9335 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request. [junit4] 2> 9336 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:2&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1 [junit4] 2> 9337 ERROR (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: xpath=*[count(//doc)=1] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int></lst><result name="response" numFound="0" start="0"></result> [junit4] 2> </response> [junit4] 2> [junit4] 2> request was:q=id:2&qt=standard&start=0&rows=20&version=2.2 [junit4] 2> 9338 ERROR (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.SolrTestCaseJ4 REQUEST FAILED: q=id:2&qt=standard&start=0&rows=20&version=2.2:java.lang.RuntimeException: REQUEST FAILED: xpath=*[count(//doc)=1] [junit4] 2> xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] 2> <response> [junit4] 2> <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int></lst><result name="response" numFound="0" start="0"></result> [junit4] 2> </response> [junit4] 2> [junit4] 2> request was:q=id:2&qt=standard&start=0&rows=20&version=2.2 [junit4] 2> at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:763) [junit4] 2> at org.apache.solr.core.TestArbitraryIndexDir.testLoadNewIndexDir(TestArbitraryIndexDir.java:128) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:502) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 9338 INFO (TEST-TestArbitraryIndexDir.testLoadNewIndexDir-seed#[54D327AB3E7DB2DB]) [ x:collection1] o.a.s.SolrTestCaseJ4 ###Ending testLoadNewIndexDir [junit4] 2> 9343 INFO (searcherExecutor-65-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@32563d84[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):c1)))} [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestArbitraryIndexDir -Dtests.method=testLoadNewIndexDir -Dtests.seed=54D327AB3E7DB2DB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en_US -Dtests.timezone=MST -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 1.05s J0 | TestArbitraryIndexDir.testLoadNewIndexDir <<< [junit4] > Throwable #1: java.lang.RuntimeException: Exception during query [junit4] > at __randomizedtesting.SeedInfo.seed([54D327AB3E7DB2DB:BD899C93A0E42273]:0) [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:770) [junit4] > at org.apache.solr.core.TestArbitraryIndexDir.testLoadNewIndexDir(TestArbitraryIndexDir.java:128) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > Caused by: java.lang.RuntimeException: REQUEST FAILED: xpath=*[count(//doc)=1] [junit4] > xml response was: <?xml version="1.0" encoding="UTF-8"?> [junit4] > <response> [junit4] > <lst name="responseHeader"><int name="status">0</int><int name="QTime">1</int></lst><result name="response" numFound="0" start="0"></result> [junit4] > </response> [junit4] > request was:q=id:2&qt=standard&start=0&rows=20&version=2.2 [junit4] > at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:763) [junit4] > ... 40 more [junit4] 2> 9377 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 9380 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1501802353 [junit4] 2> 9380 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2fd13915 [junit4] 2> 9380 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.u.UpdateHandler closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4] 2> 9380 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState [junit4] 2> 9381 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 9381 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser [junit4] 2> 9381 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request. [junit4] 2> 9382 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockFSDirectoryFactory - 3 directories currently being tracked [junit4] 2> 9382 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001;done=false>>] [junit4] 2> 9382 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001 [junit4] 2> 9382 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index_temp [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index_temp;done=false>>] [junit4] 2> 9383 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index_temp [junit4] 2> 9390 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index;done=false>>] [junit4] 2> 9390 INFO (SUITE-TestArbitraryIndexDir-seed#[54D327AB3E7DB2DB]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001/tempDir-001/index [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/temp/solr.core.TestArbitraryIndexDir 54D327AB3E7DB2DB-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {name=PostingsFormat(name=LuceneVarGapFixedInterval), id=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=en_US, timezone=MST [junit4] 2> NOTE: Linux 3.13.0-53-generic amd64/Oracle Corporation 1.9.0-ea (64-bit)/cpus=12,threads=1,free=387156208,total=508887040 [junit4] 2> NOTE: All tests run in this JVM: [TestStressLucene, TermsComponentTest, SolrIndexConfigTest, TestUpdate, TestDFRSimilarityFactory, AddBlockUpdateTest, TestArbitraryIndexDir] [junit4] Completed [14/505] on J0 in 1.09s, 1 test, 1 error <<< FAILURES! [...truncated 1514 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:526: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:474: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:61: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/extra-targets.xml:39: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:230: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:512: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1418: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:973: There were test failures: 505 suites, 1989 tests, 1 error, 58 ignored (25 assumptions) Total time: 45 minutes 50 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts 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