You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/07/04 13:42:52 UTC
[JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.8.0) - Build # 2431 -
Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2431/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.search.TestSearcherReuse.test
Error Message:
expected same:<Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}> was not:<Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}>
Stack Trace:
java.lang.AssertionError: expected same:<Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}> was not:<Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}>
at __randomizedtesting.SeedInfo.seed([7F61C8F34E5F031B:F735F729E0A36EE3]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotSame(Assert.java:641)
at org.junit.Assert.assertSame(Assert.java:580)
at org.junit.Assert.assertSame(Assert.java:593)
at org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247)
at org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117)
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: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)
Build Log:
[...truncated 10972 lines...]
[junit4] Suite: org.apache.solr.search.TestSearcherReuse
[junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001
[junit4] 2> 2069727 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 2069733 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 2069733 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/'
[junit4] 2> 2069793 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 2069796 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
[junit4] 2> 2069802 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-managed-schema.xml
[junit4] 2> 2069806 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema-id-and-version-fields-only.xml instead
[junit4] 2> 2069807 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml
[junit4] 2> 2069810 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=id-and-version-fields-only
[junit4] 2> 2069812 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 2069812 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/managed-schema
[junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml.bak
[junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001
[junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/'
[junit4] 2> 2069858 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 1872576839
[junit4] 2> 2069858 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/]
[junit4] 2> 2069859 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer loading shared library: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/lib
[junit4] 2> 2069859 WARN (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/lib).
[junit4] 2> 2069868 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] 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> 2069871 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 2069872 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2069873 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2069873 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 2069875 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig-managed-schema.xml, transient=false, schema=managed-schema, loadOnStartup=true, instanceDir=collection1, collection=collection1, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001, shard=shard1}
[junit4] 2> 2069876 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/'
[junit4] 2> 2069924 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 2069931 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
[junit4] 2> 2069953 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-managed-schema.xml
[junit4] 2> 2069960 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/managed-schema
[junit4] 2> 2069963 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=id-and-version-fields-only
[junit4] 2> 2069969 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 2069969 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/
[junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.NRTCachingDirectoryFactory
[junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/], dataDir=[null]
[junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
[junit4] 2> 2069971 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001
[junit4] 2> 2069972 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index/
[junit4] 2> 2069972 WARN (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index' doesn't exist. Creating new index...
[junit4] 2> 2069973 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index
[junit4] 2> 2069973 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1008944197, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 2069977 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 2069977 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 2069978 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/
[junit4] 2> 2069981 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 2069981 WARN (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
[junit4] 2> 2069995 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2069996 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2069998 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2069999 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2070002 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 2070002 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 2070003 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 2070003 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 2070004 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=66.8466796875, floorSegmentMB=2.048828125, forceMergeDeletesPctAllowed=18.086856904575228, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@4b5d9ece[collection1] main
[junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf
[junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf}
[junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf
[junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2070011 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 2070011 INFO (searcherExecutor-4739-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4b5d9ece[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2070012 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 2070022 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 2070024 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 1
[junit4] 2> 2070026 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2070038 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
[junit4] 2> 2070039 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 2070043 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@2e562ac5[collection1] main
[junit4] 2> 2070044 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 2070044 INFO (searcherExecutor-4739-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
[junit4] 2> 2070046 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 19
[junit4] 2> 2070046 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit.
[junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 0
[junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit.
[junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 1
[junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 2070051 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 0
[junit4] 2> 2070051 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 1
[junit4] 2> 2070054 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=id:match_no_documents} 0 0
[junit4] 2> 2070054 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2070060 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
[junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
[junit4] 2> 2070060 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation = 3
[junit4] 2> 2070061 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@14a5da73[collection1] main
[junit4] 2> 2070061 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 2070061 INFO (searcherExecutor-4739-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
[junit4] 2> 2070062 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 7
[junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
[junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
[junit4] 2> 2070064 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2070067 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
[junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_4,generation=4}
[junit4] 2> 2070067 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation = 4
[junit4] 2> 2070068 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@1ee12eea[collection1] main
[junit4] 2> 2070068 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 2070069 INFO (searcherExecutor-4739-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ee12eea[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2070070 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 6
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSearcherReuse -Dtests.method=test -Dtests.seed=7F61C8F34E5F031B -Dtests.slow=true -Dtests.locale=is -Dtests.timezone=BET -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.07s J0 | TestSearcherReuse.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected same:<Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}> was not:<Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}>
[junit4] > at __randomizedtesting.SeedInfo.seed([7F61C8F34E5F031B:F735F729E0A36EE3]:0)
[junit4] > at org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247)
[junit4] > at org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2070078 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 2070078 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1872576839
[junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2653c190
[junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.UpdateHandler closing DirectUpdateHandler2{commits=7,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=2,cumulative_errors=0}
[junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 2070080 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 2070080 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index;done=false>>]
[junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index
[junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001 [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001;done=false>>]
[junit4] 2> 2070082 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001
[junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=is, timezone=BET
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_45 (64-bit)/cpus=3,threads=1,free=250051392,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestCollationField, TriLevelCompositeIdRoutingTest, TestRestManager, VersionInfoTest, HdfsDirectoryFactoryTest, DefaultValueUpdateProcessorTest, FacetPivotSmallTest, TestRequestStatusCollectionAPI, RemoteQueryErrorTest, TestArbitraryIndexDir, ShardSplitTest, SliceStateTest, DocExpirationUpdateProcessorFactoryTest, TestBlobHandler, DistributedFacetPivotLongTailTest, TestCopyFieldCollectionResource, SolrCoreCheckLockOnStartupTest, TestFieldSortValues, TestDistributedStatsComponentCardinality, TestBinaryResponseWriter, OutOfBoxZkACLAndCredentialsProvidersTest, TestObjectReleaseTracker, TestQueryUtils, TestStressReorder, RulesTest, CustomCollectionTest, TestPerFieldSimilarity, OverseerStatusTest, TestSolrIndexConfig, TestExtendedDismaxParser, CoreAdminHandlerTest, DocumentAnalysisRequestHandlerTest, SharedFSAutoReplicaFailoverTest, TestStressLucene, TestReplicationHandler, BasicDistributedZkTest, TestConfigReload, TestIndexSearcher, AsyncMigrateRouteKeyTest, TestBinaryField, DistributedExpandComponentTest, TestPhraseSuggestions, TestGroupingSearch, DistributedQueryComponentCustomSortTest, TestClassNameShortening, HttpPartitionTest, TestTrackingShardHandlerFactory, ZkCLITest, TestHashPartitioner, DistributedSuggestComponentTest, TestAnalyzedSuggestions, DirectSolrConnectionTest, JSONWriterTest, SystemInfoHandlerTest, TestSolrCloudWithKerberosAlt, NoCacheHeaderTest, TestCloudSchemaless, SuggesterTest, SynonymTokenizerTest, DocValuesTest, ClusterStateTest, ActionThrottleTest, AddSchemaFieldsUpdateProcessorFactoryTest, ZkStateWriterTest, TestReRankQParserPlugin, PreAnalyzedFieldTest, TestAtomicUpdateErrorCases, ShardRoutingTest, SoftAutoCommitTest, TestExpandComponent, CoreMergeIndexesAdminHandlerTest, TestOmitPositions, TestWordDelimiterFilterFactory, RecoveryZkTest, TestManagedStopFilterFactory, SOLR749Test, SortByFunctionTest, ParsingFieldUpdateProcessorsTest, LeaderElectionTest, QueryElevationComponentTest, TestInitParams, OverseerTest, SolrCoreTest, TestLFUCache, TestSimpleTrackingShardHandler, TestLazyCores, TestDistribDocBasedVersion, DistributedQueryElevationComponentTest, TestSchemaSimilarityResource, SampleTest, TestDistributedSearch, HdfsRecoverLeaseTest, CursorPagingTest, TestSchemaResource, TestTrieFacet, UniqFieldsUpdateProcessorFactoryTest, TestExactStatsCache, SuggesterWFSTTest, TestSchemaManager, BJQParserTest, AnalysisAfterCoreReloadTest, TestJsonRequest, TestDynamicFieldCollectionResource, DistributedFacetPivotWhiteBoxTest, DirectUpdateHandlerTest, TestEmbeddedSolrServerConstructors, SolrInfoMBeanTest, MigrateRouteKeyTest, TestShardHandlerFactory, FieldAnalysisRequestHandlerTest, TestLeaderElectionZkExpiry, TestDefaultSearchFieldResource, TestSearcherReuse]
[junit4] Completed [375/507] on J0 in 0.37s, 1 test, 1 failure <<< FAILURES!
[...truncated 417 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:536: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:484: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:230: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:512: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1444: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:999: There were test failures: 507 suites, 2009 tests, 1 failure, 64 ignored (24 assumptions)
Total time: 76 minutes 25 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
RE: [JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.8.0) - Build # 2431 - Failure!
Posted by Uwe Schindler <uw...@thetaphi.de>.
This fails out oft he box for every run on 5.x (reproducible).
-----
Uwe Schindler
H.-H.-Meier-Allee 63, D-28213 Bremen
http://www.thetaphi.de
eMail: uwe@thetaphi.de
> -----Original Message-----
> From: Policeman Jenkins Server [mailto:jenkins@thetaphi.de]
> Sent: Saturday, July 04, 2015 1:43 PM
> To: mikemccand@apache.org; dev@lucene.apache.org
> Subject: [JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.8.0) - Build # 2431 -
> Failure!
>
> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2431/
> Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
>
> 1 tests failed.
> FAILED: org.apache.solr.search.TestSearcherReuse.test
>
> Error Message:
> expected same:<Searcher@2e562ac5[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5
> .3.0):C1)))}> was not:<Searcher@14a5da73[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5
> .3.0):C1)))}>
>
> Stack Trace:
> java.lang.AssertionError: expected same:<Searcher@2e562ac5[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5
> .3.0):C1)))}> was not:<Searcher@14a5da73[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5
> .3.0):C1)))}>
> at
> __randomizedtesting.SeedInfo.seed([7F61C8F34E5F031B:F735F729E0A36EE3
> ]:0)
> at org.junit.Assert.fail(Assert.java:93)
> at org.junit.Assert.failNotSame(Assert.java:641)
> at org.junit.Assert.assertSame(Assert.java:580)
> at org.junit.Assert.assertSame(Assert.java:593)
> at
> org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(T
> estSearcherReuse.java:247)
> at
> org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.j
> ava:62)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAcces
> sorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:497)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomize
> dRunner.java:1627)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Rando
> mizedRunner.java:836)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Rando
> mizedRunner.java:872)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Rando
> mizedRunner.java:886)
> at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.
> evaluate(SystemPropertiesRestoreRule.java:57)
> at
> org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRule
> SetupTeardownChained.java:50)
> at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeA
> fterRule.java:46)
> at
> org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleTh
> readAndTestName.java:49)
> at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRule
> IgnoreAfterMaxFailures.java:65)
> at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure
> .java:48)
> at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat
> ementAdapter.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(ThreadL
> eakControl.java:458)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran
> domizedRunner.java:845)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(Rando
> mizedRunner.java:747)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(Rando
> mizedRunner.java:781)
> at
> com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Rando
> mizedRunner.java:792)
> at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat
> ementAdapter.java:36)
> at
> com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.
> evaluate(SystemPropertiesRestoreRule.java:57)
> at
> org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeA
> fterRule.java:46)
> at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat
> ementAdapter.java:36)
> at
> org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreCl
> assName.java:42)
> at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
> at
> com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet
> hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
> at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat
> ementAdapter.java:36)
> at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat
> ementAdapter.java:36)
> at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat
> ementAdapter.java:36)
> at
> org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAss
> ertionsRequired.java:54)
> at
> org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure
> .java:48)
> at
> org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRule
> IgnoreAfterMaxFailures.java:65)
> at
> org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnore
> TestSuites.java:55)
> at
> com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat
> ementAdapter.java:36)
> at
> com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.
> run(ThreadLeakControl.java:365)
> at java.lang.Thread.run(Thread.java:745)
>
>
>
>
> Build Log:
> [...truncated 10972 lines...]
> [junit4] Suite: org.apache.solr.search.TestSearcherReuse
> [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001
> [junit4] 2> 2069727 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl
> (false) and clientAuth (false)
> [junit4] 2> 2069733 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
> [junit4] 2> 2069733 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader new
> SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-
> 5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/'
> [junit4] 2> 2069793 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrConfig current version of
> requestparams : -1
> [junit4] 2> 2069796 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrConfig Using Lucene
> MatchVersion: 5.3.0
> [junit4] 2> 2069802 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.Config Loaded SolrConfig:
> solrconfig-managed-schema.xml
> [junit4] 2> 2069806 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ]
> o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed,
> but managed schema resource managed-schema not found - loading non-
> managed schema schema-id-and-version-fields-only.xml instead
> [junit4] 2> 2069807 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema Reading Solr
> Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml
> [junit4] 2> 2069810 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema [null] Schema
> name=id-and-version-fields-only
> [junit4] 2> 2069812 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema unique key
> field: id
> [junit4] 2> 2069812 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema Upgraded to
> managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/conf/managed-schema
> [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ]
> o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema,
> renamed the non-managed schema /Users/jenkins/workspace/Lucene-Solr-
> 5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml to
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/conf/schema-id-and-version-fields-
> only.xml.bak
> [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not
> configured for solr (NoInitialContextEx)
> [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader using
> system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001
> [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader new
> SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-
> 5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/'
> [junit4] 2> 2069858 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer New
> CoreContainer 1872576839
> [junit4] 2> 2069858 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer Loading cores
> into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/]
> [junit4] 2> 2069859 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer loading shared
> library: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/lib
> [junit4] 2> 2069859 WARN (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader Can't find
> (or read) directory to add to classloader: lib (resolved as:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/lib).
> [junit4] 2> 2069868 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] 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> 2069871 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.u.UpdateShardHandler
> Creating UpdateShardHandler HTTP client with params:
> socketTimeout=30000&connTimeout=30000&retry=true
> [junit4] 2> 2069872 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is
> org.slf4j.impl.Log4jLoggerFactory
> [junit4] 2> 2069873 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.l.LogWatcher Registering Log
> Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
> [junit4] 2> 2069873 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer No
> authentication plugin used.
> [junit4] 2> 2069875 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrCore Created
> CoreDescriptor: {name=collection1, config=solrconfig-managed-schema.xml,
> transient=false, schema=managed-schema, loadOnStartup=true,
> instanceDir=collection1, collection=collection1,
> absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/, dataDir=/Users/jenkins/workspace/Lucene-
> Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001, shard=shard1}
> [junit4] 2> 2069876 INFO (coreLoadExecutor-4738-thread-1) [ ]
> o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
> '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/'
> [junit4] 2> 2069924 INFO (coreLoadExecutor-4738-thread-1) [ ]
> o.a.s.c.SolrConfig current version of requestparams : -1
> [junit4] 2> 2069931 INFO (coreLoadExecutor-4738-thread-1) [ ]
> o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
> [junit4] 2> 2069953 INFO (coreLoadExecutor-4738-thread-1) [ ]
> o.a.s.c.Config Loaded SolrConfig: solrconfig-managed-schema.xml
> [junit4] 2> 2069960 INFO (coreLoadExecutor-4738-thread-1) [ ]
> o.a.s.s.IndexSchema Reading Solr Schema from
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/conf/managed-schema
> [junit4] 2> 2069963 INFO (coreLoadExecutor-4738-thread-1) [ ]
> o.a.s.s.IndexSchema [collection1] Schema name=id-and-version-fields-only
> [junit4] 2> 2069969 INFO (coreLoadExecutor-4738-thread-1) [ ]
> o.a.s.s.IndexSchema unique key field: id
> [junit4] 2> 2069969 INFO (coreLoadExecutor-4738-thread-1) [ ]
> o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
> instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/
> [junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore solr.NRTCachingDirectoryFactory
> [junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
> [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/], dataDir=[null]
> [junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core:
> collection1
> [junit4] 2> 2069971 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001
> [junit4] 2> 2069972 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
> new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index/
> [junit4] 2> 2069972 WARN (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
> '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index' doesn't exist. Creating new index...
> [junit4] 2> 2069973 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> [junit4] 2> 2069973 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping
> class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
> minMergeSize=0, mergeFactor=10, maxMergeSize=1008944197,
> maxMergeSizeForForcedMerge=9223372036854775807,
> calibrateSizeByDeletes=true, maxMergeDocs=2147483647,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
> [junit4] 2> 2069977 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/
> workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624;
> maxCacheMB=48.0
> maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
> [junit4] 2> 2069977 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore newest commit generation = 1
> [junit4] 2> 2069978 INFO (OldIndexDirectoryCleanupThreadForCore-
> collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories
> to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/
> [junit4] 2> 2069981 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
> default, creating implicit default
> [junit4] 2> 2069981 WARN (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in
> requestHandler {type = requestHandler,name = /dump,class =
> DumpRequestHandler,args = {defaults={a=A,b=B}}}
> [junit4] 2> 2069995 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2069996 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2069998 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2069999 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2070002 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.RequestHandlers Registered paths:
> /admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/lu
> ke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/c
> onfig,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads
> ,/admin/ping,/update,/admin/file
> [junit4] 2> 2070002 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
> org.apache.solr.search.stats.LocalStatsCache
> [junit4] 2> 2070003 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
> [junit4] 2> 2070003 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
> [junit4] 2> 2070004 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping
> class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
> maxMergeAtOnce=47, maxMergeAtOnceExplicit=44,
> maxMergedSegmentMB=66.8466796875, floorSegmentMB=2.048828125,
> forceMergeDeletesPctAllowed=18.086856904575228, segmentsPerTier=10.0,
> maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
> [junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/
> workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624;
> maxCacheMB=48.0
> maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
> [junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.SolrCore newest commit generation = 1
> [junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.s.SolrIndexSearcher Opening
> Searcher@4b5d9ece[collection1] main
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized
> to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/conf
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs:
> {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/conf}
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json
> using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/tempDir-001/collection1/conf
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.r.RestManager Initializing 0 registered
> ManagedResources
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
> [junit4] 2> 2070011 INFO (coreLoadExecutor-4738-thread-1) [
> x:collection1] o.a.s.c.CoreContainer registering core: collection1
> [junit4] 2> 2070011 INFO (searcherExecutor-4739-thread-1-processing-
> x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new
> searcher Searcher@4b5d9ece[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 2070012 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
> end
> [junit4] 2> 2070022 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
> [junit4] 2> 2070024 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={} {add=[1]} 0 1
> [junit4] 2> 2070026 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDel
> etes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070038 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore
> SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/
> workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624;
> maxCacheMB=48.0
> maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/
> workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624;
> maxCacheMB=48.0
> maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
> [junit4] 2> 2070039 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation =
> 2
> [junit4] 2> 2070043 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening
> Searcher@2e562ac5[collection1] main
> [junit4] 2> 2070044 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070044 INFO (searcherExecutor-4739-thread-1) [ ]
> o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@2e562ac5[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5
> .3.0):C1)))}
> [junit4] 2> 2070046 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={} {commit=} 0 19
> [junit4] 2> 2070046 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.S.Request [collection1] webapp=null
> path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2}
> hits=1 status=0 QTime=0
> [junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDel
> etes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler No uncommitted
> changes. Skipping IW.commit.
> [junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not
> changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
> [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={} {commit=} 0 0
> [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDel
> etes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler No uncommitted
> changes. Skipping IW.commit.
> [junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not
> changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
> [junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={} {commit=} 0 1
> [junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDel
> etes=false,softCommit=true,prepareCommit=false}
> [junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not
> changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
> [junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070051 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={} {commit=} 0 0
> [junit4] 2> 2070051 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDel
> etes=false,softCommit=true,prepareCommit=false}
> [junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not
> changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
> [junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={} {commit=} 0 1
> [junit4] 2> 2070054 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={}
> {deleteByQuery=id:match_no_documents} 0 0
> [junit4] 2> 2070054 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDel
> etes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070060 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore
> SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/
> workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624;
> maxCacheMB=48.0
> maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/
> workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624;
> maxCacheMB=48.0
> maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
> [junit4] 2> 2070060 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation =
> 3
> [junit4] 2> 2070061 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening
> Searcher@14a5da73[collection1] main
> [junit4] 2> 2070061 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070061 INFO (searcherExecutor-4739-thread-1) [ ]
> o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@14a5da73[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5
> .3.0):C1)))}
> [junit4] 2> 2070062 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={} {commit=} 0 7
> [junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
> [junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL
> DOCUMENTS FROM INDEX
> [junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={} {deleteByQuery=*:*} 0 0
> [junit4] 2> 2070064 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start
> commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDel
> etes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070067 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore
> SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/
> workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624;
> maxCacheMB=48.0
> maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
> [junit4] 2>
> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/
> workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624;
> maxCacheMB=48.0
> maxMergeSizeMB=4.0),segFN=segments_4,generation=4}
> [junit4] 2> 2070067 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation =
> 4
> [junit4] 2> 2070068 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening
> Searcher@1ee12eea[collection1] main
> [junit4] 2> 2070068 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070069 INFO (searcherExecutor-4739-thread-1) [ ]
> o.a.s.c.SolrCore [collection1] Registered new searcher
> Searcher@1ee12eea[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 2070070 INFO (TEST-TestSearcherReuse.test-
> seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1]
> webapp=null path=null params={} {commit=} 0 6
> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSearcherReuse
> -Dtests.method=test -Dtests.seed=7F61C8F34E5F031B -Dtests.slow=true -
> Dtests.locale=is -Dtests.timezone=BET -Dtests.asserts=true -
> Dtests.file.encoding=US-ASCII
> [junit4] FAILURE 0.07s J0 | TestSearcherReuse.test <<<
> [junit4] > Throwable #1: java.lang.AssertionError: expected
> same:<Searcher@2e562ac5[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5
> .3.0):C1)))}> was not:<Searcher@14a5da73[collection1]
> main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5
> .3.0):C1)))}>
> [junit4] > at
> __randomizedtesting.SeedInfo.seed([7F61C8F34E5F031B:F735F729E0A36EE3
> ]:0)
> [junit4] > at
> org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(T
> estSearcherReuse.java:247)
> [junit4] > at
> org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> [junit4] 2> 2070078 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
> [junit4] 2> 2070078 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer Shutting down
> CoreContainer instance=1872576839
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.SolrCore
> [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2653c190
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.UpdateHandler
> closing DirectUpdateHandler2{commits=7,autocommits=0,soft
> autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,
> adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cum
> ulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0}
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.SolrCoreState
> Closing SolrCoreState
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1]
> o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing
> IndexWriter
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1]
> o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
> [junit4] 2> 2070080 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.SolrCore
> [collection1] Closing main searcher on request.
> [junit4] 2> 2070080 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1]
> o.a.s.c.CachingDirectoryFactory Closing NRTCachingDirectoryFactory - 2
> directories currently being tracked
> [junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1]
> o.a.s.c.CachingDirectoryFactory looking to close
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index;done=false>>]
> [junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1]
> o.a.s.c.CachingDirectoryFactory Closing directory:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001/index
> [junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1]
> o.a.s.c.CachingDirectoryFactory looking to close
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001
> [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-
> MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001;done=false>>]
> [junit4] 2> 2070082 INFO (SUITE-TestSearcherReuse-
> seed#[7F61C8F34E5F031B]-worker) [ x:collection1]
> o.a.s.c.CachingDirectoryFactory Closing directory:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-
> 001/init-core-data-001
> [junit4] 2> NOTE: leaving temporary files on disk at:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-
> core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001
> [junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {},
> docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=no):
> {}, locale=is, timezone=BET
> [junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_45 (64-
> bit)/cpus=3,threads=1,free=250051392,total=518979584
> [junit4] 2> NOTE: All tests run in this JVM: [TestCollationField,
> TriLevelCompositeIdRoutingTest, TestRestManager, VersionInfoTest,
> HdfsDirectoryFactoryTest, DefaultValueUpdateProcessorTest,
> FacetPivotSmallTest, TestRequestStatusCollectionAPI,
> RemoteQueryErrorTest, TestArbitraryIndexDir, ShardSplitTest,
> SliceStateTest, DocExpirationUpdateProcessorFactoryTest, TestBlobHandler,
> DistributedFacetPivotLongTailTest, TestCopyFieldCollectionResource,
> SolrCoreCheckLockOnStartupTest, TestFieldSortValues,
> TestDistributedStatsComponentCardinality, TestBinaryResponseWriter,
> OutOfBoxZkACLAndCredentialsProvidersTest, TestObjectReleaseTracker,
> TestQueryUtils, TestStressReorder, RulesTest, CustomCollectionTest,
> TestPerFieldSimilarity, OverseerStatusTest, TestSolrIndexConfig,
> TestExtendedDismaxParser, CoreAdminHandlerTest,
> DocumentAnalysisRequestHandlerTest, SharedFSAutoReplicaFailoverTest,
> TestStressLucene, TestReplicationHandler, BasicDistributedZkTest,
> TestConfigReload, TestIndexSearcher, AsyncMigrateRouteKeyTest,
> TestBinaryField, DistributedExpandComponentTest, TestPhraseSuggestions,
> TestGroupingSearch, DistributedQueryComponentCustomSortTest,
> TestClassNameShortening, HttpPartitionTest,
> TestTrackingShardHandlerFactory, ZkCLITest, TestHashPartitioner,
> DistributedSuggestComponentTest, TestAnalyzedSuggestions,
> DirectSolrConnectionTest, JSONWriterTest, SystemInfoHandlerTest,
> TestSolrCloudWithKerberosAlt, NoCacheHeaderTest, TestCloudSchemaless,
> SuggesterTest, SynonymTokenizerTest, DocValuesTest, ClusterStateTest,
> ActionThrottleTest, AddSchemaFieldsUpdateProcessorFactoryTest,
> ZkStateWriterTest, TestReRankQParserPlugin, PreAnalyzedFieldTest,
> TestAtomicUpdateErrorCases, ShardRoutingTest, SoftAutoCommitTest,
> TestExpandComponent, CoreMergeIndexesAdminHandlerTest,
> TestOmitPositions, TestWordDelimiterFilterFactory, RecoveryZkTest,
> TestManagedStopFilterFactory, SOLR749Test, SortByFunctionTest,
> ParsingFieldUpdateProcessorsTest, LeaderElectionTest,
> QueryElevationComponentTest, TestInitParams, OverseerTest, SolrCoreTest,
> TestLFUCache, TestSimpleTrackingShardHandler, TestLazyCores,
> TestDistribDocBasedVersion, DistributedQueryElevationComponentTest,
> TestSchemaSimilarityResource, SampleTest, TestDistributedSearch,
> HdfsRecoverLeaseTest, CursorPagingTest, TestSchemaResource,
> TestTrieFacet, UniqFieldsUpdateProcessorFactoryTest, TestExactStatsCache,
> SuggesterWFSTTest, TestSchemaManager, BJQParserTest,
> AnalysisAfterCoreReloadTest, TestJsonRequest,
> TestDynamicFieldCollectionResource, DistributedFacetPivotWhiteBoxTest,
> DirectUpdateHandlerTest, TestEmbeddedSolrServerConstructors,
> SolrInfoMBeanTest, MigrateRouteKeyTest, TestShardHandlerFactory,
> FieldAnalysisRequestHandlerTest, TestLeaderElectionZkExpiry,
> TestDefaultSearchFieldResource, TestSearcherReuse]
> [junit4] Completed [375/507] on J0 in 0.37s, 1 test, 1 failure <<< FAILURES!
>
> [...truncated 417 lines...]
> BUILD FAILED
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:536: The
> following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:484: The
> following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The
> following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39:
> The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:230: The
> following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-
> build.xml:512: The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-
> build.xml:1444: The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-
> build.xml:999: There were test failures: 507 suites, 2009 tests, 1 failure, 64
> ignored (24 assumptions)
>
> Total time: 76 minutes 25 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-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org
Re: [JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.8.0) - Build # 2431
- Failure!
Posted by Chris Hostetter <ho...@fucit.org>.
FWIW: Steve looked in to this a bit ago and filed SOLR-7611...
https://issues.apache.org/jira/browse/SOLR-7611
...my impression at the time was that LUCENE-6505 totally invalidated the
entire premise of the test, but i didn't spend that much time looking into
it. But then stem said he was able to reproduce some failures even after
he rolled back LUCENE-6505 -- which left me more confused.
I honestly have no idea what's going on and haven't really had time to
think about it any more.
I suspect that there may be 2 unrelated problems here that exhibit the
same symptoms...
1) something that's been broken a while that causes some seeds to fail.
2) mike's change in LUCENE-6505 which (seems to) eliminate the point of
the feature being tested here and as a result changed the test in a way
that may by making #1 happen more often (ie: with more seeds)
: Date: Sat, 4 Jul 2015 17:50:30 -0400
: From: Michael McCandless <lu...@mikemccandless.com>
: Reply-To: dev@lucene.apache.org
: To: Lucene/Solr dev <de...@lucene.apache.org>
: Subject: Re: [JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.8.0) - Build # 2431
: - Failure!
:
: Hmm this is probably from LUCENE-6505 ... I'll dig.
:
: Mike McCandless
:
: http://blog.mikemccandless.com
:
:
: On Sat, Jul 4, 2015 at 7:42 AM, Policeman Jenkins Server
: <je...@thetaphi.de> wrote:
: > Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2431/
: > Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
: >
: > 1 tests failed.
: > FAILED: org.apache.solr.search.TestSearcherReuse.test
: >
: > Error Message:
: > expected same:<Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}> was not:<Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}>
: >
: > Stack Trace:
: > java.lang.AssertionError: expected same:<Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}> was not:<Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}>
: > at __randomizedtesting.SeedInfo.seed([7F61C8F34E5F031B:F735F729E0A36EE3]:0)
: > at org.junit.Assert.fail(Assert.java:93)
: > at org.junit.Assert.failNotSame(Assert.java:641)
: > at org.junit.Assert.assertSame(Assert.java:580)
: > at org.junit.Assert.assertSame(Assert.java:593)
: > at org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247)
: > at org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117)
: > 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: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)
: >
: >
: >
: >
: > Build Log:
: > [...truncated 10972 lines...]
: > [junit4] Suite: org.apache.solr.search.TestSearcherReuse
: > [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001
: > [junit4] 2> 2069727 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
: > [junit4] 2> 2069733 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
: > [junit4] 2> 2069733 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/'
: > [junit4] 2> 2069793 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
: > [junit4] 2> 2069796 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
: > [junit4] 2> 2069802 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-managed-schema.xml
: > [junit4] 2> 2069806 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema-id-and-version-fields-only.xml instead
: > [junit4] 2> 2069807 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml
: > [junit4] 2> 2069810 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=id-and-version-fields-only
: > [junit4] 2> 2069812 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema unique key field: id
: > [junit4] 2> 2069812 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/managed-schema
: > [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml.bak
: > [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
: > [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001
: > [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/'
: > [junit4] 2> 2069858 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 1872576839
: > [junit4] 2> 2069858 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/]
: > [junit4] 2> 2069859 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer loading shared library: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/lib
: > [junit4] 2> 2069859 WARN (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/lib).
: > [junit4] 2> 2069868 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] 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> 2069871 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
: > [junit4] 2> 2069872 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
: > [junit4] 2> 2069873 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
: > [junit4] 2> 2069873 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used.
: > [junit4] 2> 2069875 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig-managed-schema.xml, transient=false, schema=managed-schema, loadOnStartup=true, instanceDir=collection1, collection=collection1, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001, shard=shard1}
: > [junit4] 2> 2069876 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/'
: > [junit4] 2> 2069924 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
: > [junit4] 2> 2069931 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
: > [junit4] 2> 2069953 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-managed-schema.xml
: > [junit4] 2> 2069960 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/managed-schema
: > [junit4] 2> 2069963 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=id-and-version-fields-only
: > [junit4] 2> 2069969 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
: > [junit4] 2> 2069969 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/
: > [junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.NRTCachingDirectoryFactory
: > [junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/], dataDir=[null]
: > [junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
: > [junit4] 2> 2069971 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001
: > [junit4] 2> 2069972 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index/
: > [junit4] 2> 2069972 WARN (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index' doesn't exist. Creating new index...
: > [junit4] 2> 2069973 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index
: > [junit4] 2> 2069973 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1008944197, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
: > [junit4] 2> 2069977 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
: > [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
: > [junit4] 2> 2069977 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
: > [junit4] 2> 2069978 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/
: > [junit4] 2> 2069981 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
: > [junit4] 2> 2069981 WARN (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
: > [junit4] 2> 2069995 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
: > [junit4] 2> 2069996 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
: > [junit4] 2> 2069998 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
: > [junit4] 2> 2069999 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
: > [junit4] 2> 2070002 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
: > [junit4] 2> 2070002 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
: > [junit4] 2> 2070003 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
: > [junit4] 2> 2070003 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
: > [junit4] 2> 2070004 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=66.8466796875, floorSegmentMB=2.048828125, forceMergeDeletesPctAllowed=18.086856904575228, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
: > [junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
: > [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
: > [junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
: > [junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@4b5d9ece[collection1] main
: > [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf
: > [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf}
: > [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf
: > [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
: > [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
: > [junit4] 2> 2070011 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
: > [junit4] 2> 2070011 INFO (searcherExecutor-4739-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4b5d9ece[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
: > [junit4] 2> 2070012 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
: > [junit4] 2> 2070022 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
: > [junit4] 2> 2070024 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 1
: > [junit4] 2> 2070026 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: > [junit4] 2> 2070038 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
: > [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
: > [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
: > [junit4] 2> 2070039 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation = 2
: > [junit4] 2> 2070043 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@2e562ac5[collection1] main
: > [junit4] 2> 2070044 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
: > [junit4] 2> 2070044 INFO (searcherExecutor-4739-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
: > [junit4] 2> 2070046 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 19
: > [junit4] 2> 2070046 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
: > [junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: > [junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit.
: > [junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
: > [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
: > [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 0
: > [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: > [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit.
: > [junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
: > [junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
: > [junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 1
: > [junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: > [junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
: > [junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
: > [junit4] 2> 2070051 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 0
: > [junit4] 2> 2070051 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
: > [junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
: > [junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
: > [junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 1
: > [junit4] 2> 2070054 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=id:match_no_documents} 0 0
: > [junit4] 2> 2070054 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: > [junit4] 2> 2070060 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
: > [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
: > [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
: > [junit4] 2> 2070060 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation = 3
: > [junit4] 2> 2070061 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@14a5da73[collection1] main
: > [junit4] 2> 2070061 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
: > [junit4] 2> 2070061 INFO (searcherExecutor-4739-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
: > [junit4] 2> 2070062 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 7
: > [junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
: > [junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
: > [junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
: > [junit4] 2> 2070064 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
: > [junit4] 2> 2070067 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
: > [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
: > [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_4,generation=4}
: > [junit4] 2> 2070067 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation = 4
: > [junit4] 2> 2070068 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@1ee12eea[collection1] main
: > [junit4] 2> 2070068 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
: > [junit4] 2> 2070069 INFO (searcherExecutor-4739-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ee12eea[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
: > [junit4] 2> 2070070 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 6
: > [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSearcherReuse -Dtests.method=test -Dtests.seed=7F61C8F34E5F031B -Dtests.slow=true -Dtests.locale=is -Dtests.timezone=BET -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
: > [junit4] FAILURE 0.07s J0 | TestSearcherReuse.test <<<
: > [junit4] > Throwable #1: java.lang.AssertionError: expected same:<Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}> was not:<Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}>
: > [junit4] > at __randomizedtesting.SeedInfo.seed([7F61C8F34E5F031B:F735F729E0A36EE3]:0)
: > [junit4] > at org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247)
: > [junit4] > at org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117)
: > [junit4] > at java.lang.Thread.run(Thread.java:745)
: > [junit4] 2> 2070078 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
: > [junit4] 2> 2070078 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1872576839
: > [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2653c190
: > [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.UpdateHandler closing DirectUpdateHandler2{commits=7,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=2,cumulative_errors=0}
: > [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
: > [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
: > [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
: > [junit4] 2> 2070080 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
: > [junit4] 2> 2070080 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
: > [junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index;done=false>>]
: > [junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index
: > [junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001 [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001;done=false>>]
: > [junit4] 2> 2070082 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001
: > [junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001
: > [junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=is, timezone=BET
: > [junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_45 (64-bit)/cpus=3,threads=1,free=250051392,total=518979584
: > [junit4] 2> NOTE: All tests run in this JVM: [TestCollationField, TriLevelCompositeIdRoutingTest, TestRestManager, VersionInfoTest, HdfsDirectoryFactoryTest, DefaultValueUpdateProcessorTest, FacetPivotSmallTest, TestRequestStatusCollectionAPI, RemoteQueryErrorTest, TestArbitraryIndexDir, ShardSplitTest, SliceStateTest, DocExpirationUpdateProcessorFactoryTest, TestBlobHandler, DistributedFacetPivotLongTailTest, TestCopyFieldCollectionResource, SolrCoreCheckLockOnStartupTest, TestFieldSortValues, TestDistributedStatsComponentCardinality, TestBinaryResponseWriter, OutOfBoxZkACLAndCredentialsProvidersTest, TestObjectReleaseTracker, TestQueryUtils, TestStressReorder, RulesTest, CustomCollectionTest, TestPerFieldSimilarity, OverseerStatusTest, TestSolrIndexConfig, TestExtendedDismaxParser, CoreAdminHandlerTest, DocumentAnalysisRequestHandlerTest, SharedFSAutoReplicaFailoverTest, TestStressLucene, TestReplicationHandler, BasicDistributedZkTest, TestConfigReload, TestIndexSearcher,
AsyncMigrateRouteKeyTest, TestBinaryField, DistributedExpandComponentTest, TestPhraseSuggestions, TestGroupingSearch, DistributedQueryComponentCustomSortTest, TestClassNameShortening, HttpPartitionTest, TestTrackingShardHandlerFactory, ZkCLITest, TestHashPartitioner, DistributedSuggestComponentTest, TestAnalyzedSuggestions, DirectSolrConnectionTest, JSONWriterTest, SystemInfoHandlerTest, TestSolrCloudWithKerberosAlt, NoCacheHeaderTest, TestCloudSchemaless, SuggesterTest, SynonymTokenizerTest, DocValuesTest, ClusterStateTest, ActionThrottleTest, AddSchemaFieldsUpdateProcessorFactoryTest, ZkStateWriterTest, TestReRankQParserPlugin, PreAnalyzedFieldTest, TestAtomicUpdateErrorCases, ShardRoutingTest, SoftAutoCommitTest, TestExpandComponent, CoreMergeIndexesAdminHandlerTest, TestOmitPositions, TestWordDelimiterFilterFactory, RecoveryZkTest, TestManagedStopFilterFactory, SOLR749Test, SortByFunctionTest, ParsingFieldUpdateProcessorsTest, LeaderElectionTest, QueryElevationComponentTest, Tes
tInitParams, OverseerTest, SolrCoreTest, TestLFUCache, TestSimpleTrackingShardHandler, TestLazyCores, TestDistribDocBasedVersion, DistributedQueryElevationComponentTest, TestSchemaSimilarityResource, SampleTest, TestDistributedSearch, HdfsRecoverLeaseTest, CursorPagingTest, TestSchemaResource, TestTrieFacet, UniqFieldsUpdateProcessorFactoryTest, TestExactStatsCache, SuggesterWFSTTest, TestSchemaManager, BJQParserTest, AnalysisAfterCoreReloadTest, TestJsonRequest, TestDynamicFieldCollectionResource, DistributedFacetPivotWhiteBoxTest, DirectUpdateHandlerTest, TestEmbeddedSolrServerConstructors, SolrInfoMBeanTest, MigrateRouteKeyTest, TestShardHandlerFactory, FieldAnalysisRequestHandlerTest, TestLeaderElectionZkExpiry, TestDefaultSearchFieldResource, TestSearcherReuse]
: > [junit4] Completed [375/507] on J0 in 0.37s, 1 test, 1 failure <<< FAILURES!
: >
: > [...truncated 417 lines...]
: > BUILD FAILED
: > /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:536: The following error occurred while executing this line:
: > /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:484: The following error occurred while executing this line:
: > /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following error occurred while executing this line:
: > /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The following error occurred while executing this line:
: > /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:230: The following error occurred while executing this line:
: > /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:512: The following error occurred while executing this line:
: > /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1444: The following error occurred while executing this line:
: > /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:999: There were test failures: 507 suites, 2009 tests, 1 failure, 64 ignored (24 assumptions)
: >
: > Total time: 76 minutes 25 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-unsubscribe@lucene.apache.org
: > For additional commands, e-mail: dev-help@lucene.apache.org
:
:
: ---------------------------------------------------------------------
: To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
: For additional commands, e-mail: dev-help@lucene.apache.org
:
:
-Hoss
http://www.lucidworks.com/
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org
Re: [JENKINS] Lucene-Solr-5.x-MacOSX (64bit/jdk1.8.0) - Build # 2431
- Failure!
Posted by Michael McCandless <lu...@mikemccandless.com>.
Hmm this is probably from LUCENE-6505 ... I'll dig.
Mike McCandless
http://blog.mikemccandless.com
On Sat, Jul 4, 2015 at 7:42 AM, Policeman Jenkins Server
<je...@thetaphi.de> wrote:
> Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-MacOSX/2431/
> Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
>
> 1 tests failed.
> FAILED: org.apache.solr.search.TestSearcherReuse.test
>
> Error Message:
> expected same:<Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}> was not:<Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}>
>
> Stack Trace:
> java.lang.AssertionError: expected same:<Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}> was not:<Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}>
> at __randomizedtesting.SeedInfo.seed([7F61C8F34E5F031B:F735F729E0A36EE3]:0)
> at org.junit.Assert.fail(Assert.java:93)
> at org.junit.Assert.failNotSame(Assert.java:641)
> at org.junit.Assert.assertSame(Assert.java:580)
> at org.junit.Assert.assertSame(Assert.java:593)
> at org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247)
> at org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117)
> 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: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)
>
>
>
>
> Build Log:
> [...truncated 10972 lines...]
> [junit4] Suite: org.apache.solr.search.TestSearcherReuse
> [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001
> [junit4] 2> 2069727 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
> [junit4] 2> 2069733 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
> [junit4] 2> 2069733 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/'
> [junit4] 2> 2069793 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
> [junit4] 2> 2069796 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
> [junit4] 2> 2069802 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-managed-schema.xml
> [junit4] 2> 2069806 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema-id-and-version-fields-only.xml instead
> [junit4] 2> 2069807 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml
> [junit4] 2> 2069810 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=id-and-version-fields-only
> [junit4] 2> 2069812 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema unique key field: id
> [junit4] 2> 2069812 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.IndexSchema Upgraded to managed schema at /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/managed-schema
> [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema, renamed the non-managed schema /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml to /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/schema-id-and-version-fields-only.xml.bak
> [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
> [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001
> [junit4] 2> 2069814 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/'
> [junit4] 2> 2069858 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 1872576839
> [junit4] 2> 2069858 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/]
> [junit4] 2> 2069859 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer loading shared library: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/lib
> [junit4] 2> 2069859 WARN (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/lib).
> [junit4] 2> 2069868 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] 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> 2069871 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
> [junit4] 2> 2069872 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
> [junit4] 2> 2069873 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
> [junit4] 2> 2069873 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used.
> [junit4] 2> 2069875 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig-managed-schema.xml, transient=false, schema=managed-schema, loadOnStartup=true, instanceDir=collection1, collection=collection1, absoluteInstDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001, shard=shard1}
> [junit4] 2> 2069876 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/'
> [junit4] 2> 2069924 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
> [junit4] 2> 2069931 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.3.0
> [junit4] 2> 2069953 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig-managed-schema.xml
> [junit4] 2> 2069960 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf/managed-schema
> [junit4] 2> 2069963 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=id-and-version-fields-only
> [junit4] 2> 2069969 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
> [junit4] 2> 2069969 INFO (coreLoadExecutor-4738-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/
> [junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.NRTCachingDirectoryFactory
> [junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/], dataDir=[null]
> [junit4] 2> 2069970 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: collection1
> [junit4] 2> 2069971 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001
> [junit4] 2> 2069972 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index/
> [junit4] 2> 2069972 WARN (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index' doesn't exist. Creating new index...
> [junit4] 2> 2069973 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index
> [junit4] 2> 2069973 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1008944197, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
> [junit4] 2> 2069977 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
> [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
> [junit4] 2> 2069977 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
> [junit4] 2> 2069978 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/
> [junit4] 2> 2069981 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
> [junit4] 2> 2069981 WARN (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class = DumpRequestHandler,args = {defaults={a=A,b=B}}}
> [junit4] 2> 2069995 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2069996 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2069998 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2069999 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
> [junit4] 2> 2070002 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/dump,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
> [junit4] 2> 2070002 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
> [junit4] 2> 2070003 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
> [junit4] 2> 2070003 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
> [junit4] 2> 2070004 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=44, maxMergedSegmentMB=66.8466796875, floorSegmentMB=2.048828125, forceMergeDeletesPctAllowed=18.086856904575228, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
> [junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
> [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
> [junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
> [junit4] 2> 2070009 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@4b5d9ece[collection1] main
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf}
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/tempDir-001/collection1/conf
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
> [junit4] 2> 2070010 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
> [junit4] 2> 2070011 INFO (coreLoadExecutor-4738-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
> [junit4] 2> 2070011 INFO (searcherExecutor-4739-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4b5d9ece[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 2070012 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
> [junit4] 2> 2070022 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
> [junit4] 2> 2070024 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 1
> [junit4] 2> 2070026 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070038 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
> [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
> [junit4] 2> 2070039 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation = 2
> [junit4] 2> 2070043 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@2e562ac5[collection1] main
> [junit4] 2> 2070044 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070044 INFO (searcherExecutor-4739-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
> [junit4] 2> 2070046 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 19
> [junit4] 2> 2070046 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=*:*&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0
> [junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit.
> [junit4] 2> 2070047 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
> [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 0
> [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070048 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler No uncommitted changes. Skipping IW.commit.
> [junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
> [junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070049 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 1
> [junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
> [junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
> [junit4] 2> 2070050 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070051 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 0
> [junit4] 2> 2070051 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
> [junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
> [junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070052 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 1
> [junit4] 2> 2070054 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=id:match_no_documents} 0 0
> [junit4] 2> 2070054 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070060 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
> [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
> [junit4] 2> 2070060 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation = 3
> [junit4] 2> 2070061 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@14a5da73[collection1] main
> [junit4] 2> 2070061 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070061 INFO (searcherExecutor-4739-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}
> [junit4] 2> 2070062 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 7
> [junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending test
> [junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore [collection1] REMOVING ALL DOCUMENTS FROM INDEX
> [junit4] 2> 2070063 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0
> [junit4] 2> 2070064 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
> [junit4] 2> 2070067 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
> [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_3,generation=3}
> [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce0a624; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_4,generation=4}
> [junit4] 2> 2070067 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.c.SolrCore newest commit generation = 4
> [junit4] 2> 2070068 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@1ee12eea[collection1] main
> [junit4] 2> 2070068 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.UpdateHandler end_commit_flush
> [junit4] 2> 2070069 INFO (searcherExecutor-4739-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ee12eea[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
> [junit4] 2> 2070070 INFO (TEST-TestSearcherReuse.test-seed#[7F61C8F34E5F031B]) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 6
> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestSearcherReuse -Dtests.method=test -Dtests.seed=7F61C8F34E5F031B -Dtests.slow=true -Dtests.locale=is -Dtests.timezone=BET -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
> [junit4] FAILURE 0.07s J0 | TestSearcherReuse.test <<<
> [junit4] > Throwable #1: java.lang.AssertionError: expected same:<Searcher@2e562ac5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}> was not:<Searcher@14a5da73[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.3.0):C1)))}>
> [junit4] > at __randomizedtesting.SeedInfo.seed([7F61C8F34E5F031B:F735F729E0A36EE3]:0)
> [junit4] > at org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247)
> [junit4] > at org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117)
> [junit4] > at java.lang.Thread.run(Thread.java:745)
> [junit4] 2> 2070078 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
> [junit4] 2> 2070078 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1872576839
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2653c190
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.UpdateHandler closing DirectUpdateHandler2{commits=7,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=2,cumulative_errors=0}
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
> [junit4] 2> 2070079 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
> [junit4] 2> 2070080 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
> [junit4] 2> 2070080 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing NRTCachingDirectoryFactory - 2 directories currently being tracked
> [junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index;done=false>>]
> [junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001/index
> [junit4] 2> 2070081 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001 [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001;done=false>>]
> [junit4] 2> 2070082 INFO (SUITE-TestSearcherReuse-seed#[7F61C8F34E5F031B]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001/init-core-data-001
> [junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.search.TestSearcherReuse_7F61C8F34E5F031B-001
> [junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=is, timezone=BET
> [junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_45 (64-bit)/cpus=3,threads=1,free=250051392,total=518979584
> [junit4] 2> NOTE: All tests run in this JVM: [TestCollationField, TriLevelCompositeIdRoutingTest, TestRestManager, VersionInfoTest, HdfsDirectoryFactoryTest, DefaultValueUpdateProcessorTest, FacetPivotSmallTest, TestRequestStatusCollectionAPI, RemoteQueryErrorTest, TestArbitraryIndexDir, ShardSplitTest, SliceStateTest, DocExpirationUpdateProcessorFactoryTest, TestBlobHandler, DistributedFacetPivotLongTailTest, TestCopyFieldCollectionResource, SolrCoreCheckLockOnStartupTest, TestFieldSortValues, TestDistributedStatsComponentCardinality, TestBinaryResponseWriter, OutOfBoxZkACLAndCredentialsProvidersTest, TestObjectReleaseTracker, TestQueryUtils, TestStressReorder, RulesTest, CustomCollectionTest, TestPerFieldSimilarity, OverseerStatusTest, TestSolrIndexConfig, TestExtendedDismaxParser, CoreAdminHandlerTest, DocumentAnalysisRequestHandlerTest, SharedFSAutoReplicaFailoverTest, TestStressLucene, TestReplicationHandler, BasicDistributedZkTest, TestConfigReload, TestIndexSearcher, AsyncMigrateRouteKeyTest, TestBinaryField, DistributedExpandComponentTest, TestPhraseSuggestions, TestGroupingSearch, DistributedQueryComponentCustomSortTest, TestClassNameShortening, HttpPartitionTest, TestTrackingShardHandlerFactory, ZkCLITest, TestHashPartitioner, DistributedSuggestComponentTest, TestAnalyzedSuggestions, DirectSolrConnectionTest, JSONWriterTest, SystemInfoHandlerTest, TestSolrCloudWithKerberosAlt, NoCacheHeaderTest, TestCloudSchemaless, SuggesterTest, SynonymTokenizerTest, DocValuesTest, ClusterStateTest, ActionThrottleTest, AddSchemaFieldsUpdateProcessorFactoryTest, ZkStateWriterTest, TestReRankQParserPlugin, PreAnalyzedFieldTest, TestAtomicUpdateErrorCases, ShardRoutingTest, SoftAutoCommitTest, TestExpandComponent, CoreMergeIndexesAdminHandlerTest, TestOmitPositions, TestWordDelimiterFilterFactory, RecoveryZkTest, TestManagedStopFilterFactory, SOLR749Test, SortByFunctionTest, ParsingFieldUpdateProcessorsTest, LeaderElectionTest, QueryElevationComponentTest, TestInitParams, OverseerTest, SolrCoreTest, TestLFUCache, TestSimpleTrackingShardHandler, TestLazyCores, TestDistribDocBasedVersion, DistributedQueryElevationComponentTest, TestSchemaSimilarityResource, SampleTest, TestDistributedSearch, HdfsRecoverLeaseTest, CursorPagingTest, TestSchemaResource, TestTrieFacet, UniqFieldsUpdateProcessorFactoryTest, TestExactStatsCache, SuggesterWFSTTest, TestSchemaManager, BJQParserTest, AnalysisAfterCoreReloadTest, TestJsonRequest, TestDynamicFieldCollectionResource, DistributedFacetPivotWhiteBoxTest, DirectUpdateHandlerTest, TestEmbeddedSolrServerConstructors, SolrInfoMBeanTest, MigrateRouteKeyTest, TestShardHandlerFactory, FieldAnalysisRequestHandlerTest, TestLeaderElectionZkExpiry, TestDefaultSearchFieldResource, TestSearcherReuse]
> [junit4] Completed [375/507] on J0 in 0.37s, 1 test, 1 failure <<< FAILURES!
>
> [...truncated 417 lines...]
> BUILD FAILED
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:536: The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:484: The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/build.xml:61: The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/extra-targets.xml:39: The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/build.xml:230: The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/solr/common-build.xml:512: The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:1444: The following error occurred while executing this line:
> /Users/jenkins/workspace/Lucene-Solr-5.x-MacOSX/lucene/common-build.xml:999: There were test failures: 507 suites, 2009 tests, 1 failure, 64 ignored (24 assumptions)
>
> Total time: 76 minutes 25 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-unsubscribe@lucene.apache.org
> For additional commands, e-mail: dev-help@lucene.apache.org
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org
For additional commands, e-mail: dev-help@lucene.apache.org