Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6309/ Java: 32bit/jdk1.8.0_112 -client -XX:+UseConcMarkSweepGC
1 tests failed. FAILED: org.apache.solr.metrics.JvmMetricsTest.testOperatingSystemMetricsSet Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([4A6A87B04A5D7ACA:5295E3C5B35B219F]:0) at org.junit.Assert.fail(Assert.java:92) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertTrue(Assert.java:54) at org.apache.solr.metrics.JvmMetricsTest.testOperatingSystemMetricsSet(JvmMetricsTest.java:51) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 12523 lines...] [junit4] Suite: org.apache.solr.metrics.JvmMetricsTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\init-core-data-001 [junit4] 2> 2941365 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) [junit4] 2> 2941560 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 2941560 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 2941561 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-002\cores\core [junit4] 2> 2941565 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 2941568 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@10f43e6{/solr,null,AVAILABLE} [junit4] 2> 2941569 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@454131{HTTP/1.1,[http/1.1]}{127.0.0.1:60094} [junit4] 2> 2941569 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.e.j.s.Server Started @2945927ms [junit4] 2> 2941569 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=60094, configSetBaseDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-002\cores} [junit4] 2> 2941570 ERROR (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 2941571 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 7.0.0 [junit4] 2> 2941571 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 2941571 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2941571 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-25T03:21:51.186Z [junit4] 2> 2941571 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\solr.xml [junit4] 2> 2941616 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001 [junit4] 2> 2941616 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2941656 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib [junit4] 2> 2941657 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist filtered by solr-cell-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 2941658 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib [junit4] 2> 2941658 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist filtered by solr-clustering-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 2941658 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib [junit4] 2> 2941658 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist filtered by solr-langid-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 2941658 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\ltr\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\ltr\lib [junit4] 2> 2941658 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist filtered by solr-ltr-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 2941664 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib filtered by .*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib [junit4] 2> 2941664 WARN (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Couldn't add files from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist filtered by solr-velocity-\d.*\.jar to classpath: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 2941676 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is enabled [junit4] 2> 2941679 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 2941748 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example [junit4] 2> 2942220 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.RestManager Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path /schema/analysis/stopwords/english [junit4] 2> 2942221 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.RestManager Registered ManagedResource impl org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager for path /schema/analysis/synonyms/english [junit4] 2> 2942223 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id [junit4] 2> 2942223 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.RestManager Added observer of type org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing ManagedResource /schema/analysis/stopwords/english [junit4] 2> 2942223 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.RestManager Added observer of type org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing ManagedResource /schema/analysis/synonyms/english [junit4] 2> 2942274 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1 [junit4] 2> 2942275 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\data\] [junit4] 2> 2942281 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@bdd491 [junit4] 2> 2942296 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: init: current segments file is "segments"; deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@65c54e [junit4] 2> 2942296 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: delete [] [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: delete [] [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: 0 msec to checkpoint [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: init: create=true [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: [junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@1611e10 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1deb272) [junit4] 2> index= [junit4] 2> version=7.0.0 [junit4] 2> analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer [junit4] 2> ramBufferSizeMB=100.0 [junit4] 2> maxBufferedDocs=-1 [junit4] 2> maxBufferedDeleteTerms=-1 [junit4] 2> mergedSegmentWarmer=null [junit4] 2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper [junit4] 2> commit=null [junit4] 2> openMode=CREATE [junit4] 2> similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$SchemaSimilarity [junit4] 2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1, maxMergeCount=-1, ioThrottle=true [junit4] 2> codec=Lucene70 [junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream [junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0, forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1 [junit4] 2> indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@b90a9a [junit4] 2> readerPooling=false [junit4] 2> perThreadHardLimitMB=1945 [junit4] 2> useCompoundFile=false [junit4] 2> commitOnClose=true [junit4] 2> indexSort=null [junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@1c30803 [junit4] 2> [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: MMapDirectory.UNMAP_SUPPORTED=true [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: now flush at close [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: start flush: applyAllDeletes=true [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: index before flush [junit4] 2> 2942297 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-9779-thread-1]: startFullFlush [junit4] 2> 2942298 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-9779-thread-1]: coreLoadExecutor-9779-thread-1 finishFullFlush success=true [junit4] 2> 2942298 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: apply all deletes during flush [junit4] 2> 2942300 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 2942300 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-9779-thread-1]: prune sis=segments: minGen=9223372036854775807 packetCount=0 [junit4] 2> 2942301 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-9779-thread-1]: initDynamicDefaults spins=false maxThreadCount=2 maxMergeCount=7 [junit4] 2> 2942301 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-9779-thread-1]: updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec [junit4] 2> 2942301 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-9779-thread-1]: now merge [junit4] 2> 2942301 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-9779-thread-1]: index: [junit4] 2> 2942303 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-9779-thread-1]: no more merges pending; now return [junit4] 2> 2942303 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: waitForMerges [junit4] 2> 2942303 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: waitForMerges done [junit4] 2> 2942303 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: commit: start [junit4] 2> 2942305 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: commit: enter lock [junit4] 2> 2942305 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: commit: now prepare [junit4] 2> 2942305 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: prepareCommit: flush [junit4] 2> 2942305 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: index before flush [junit4] 2> 2942305 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-9779-thread-1]: startFullFlush [junit4] 2> 2942305 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: apply all deletes during flush [junit4] 2> 2942305 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 2942306 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-9779-thread-1]: prune sis=segments: minGen=9223372036854775807 packetCount=0 [junit4] 2> 2942306 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-9779-thread-1]: coreLoadExecutor-9779-thread-1 finishFullFlush success=true [junit4] 2> 2942307 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: startCommit(): start [junit4] 2> 2942307 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: startCommit index= changeCount=2 [junit4] 2> 2942308 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: startCommit: wrote pending segments file "pending_segments_1" [junit4] 2> 2942308 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: done all syncs: [] [junit4] 2> 2942308 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: commit: pendingCommit != null [junit4] 2> 2942308 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: commit: done writing segments file "segments_1" [junit4] 2> 2942308 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: now checkpoint "" [0 segments ; isCommit = true] [junit4] 2> 2942308 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: 0 msec to checkpoint [junit4] 2> 2942308 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: delete [] [junit4] 2> 2942309 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: commit: took 3.7 msec [junit4] 2> 2942310 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: commit: done [junit4] 2> 2942311 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: rollback [junit4] 2> 2942311 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: all running merges have aborted [junit4] 2> 2942311 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: rollback: done finish merges [junit4] 2> 2942312 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-9779-thread-1]: abort [junit4] 2> 2942312 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-9779-thread-1]: done abort success=true [junit4] 2> 2942313 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: rollback: infos= [junit4] 2> 2942313 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 2942313 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: delete [] [junit4] 2> 2942313 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: 0 msec to checkpoint [junit4] 2> 2942313 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: delete [] [junit4] 2> 2942314 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5 [junit4] 2> 2942389 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 2942389 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 2942393 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; [junit4] 2> 2942396 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2942411 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: init: current segments file is "segments_1"; deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@65c54e [junit4] 2> 2942411 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: init: load commit "segments_1" [junit4] 2> 2942412 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: delete [] [junit4] 2> 2942413 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 2942413 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: delete [] [junit4] 2> 2942414 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-9779-thread-1]: 1 msec to checkpoint [junit4] 2> 2942415 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: init: create=false [junit4] 2> 2942415 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: [junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@1611e10 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1deb272) [junit4] 2> index= [junit4] 2> version=7.0.0 [junit4] 2> analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer [junit4] 2> ramBufferSizeMB=100.0 [junit4] 2> maxBufferedDocs=-1 [junit4] 2> maxBufferedDeleteTerms=-1 [junit4] 2> mergedSegmentWarmer=null [junit4] 2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper [junit4] 2> commit=null [junit4] 2> openMode=APPEND [junit4] 2> similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$SchemaSimilarity [junit4] 2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1, maxMergeCount=-1, ioThrottle=true [junit4] 2> codec=Lucene70 [junit4] 2> infoStream=org.apache.solr.update.LoggingInfoStream [junit4] 2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0, forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1 [junit4] 2> indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@1766161 [junit4] 2> readerPooling=false [junit4] 2> perThreadHardLimitMB=1945 [junit4] 2> useCompoundFile=false [junit4] 2> commitOnClose=true [junit4] 2> indexSort=null [junit4] 2> writer=org.apache.solr.update.SolrIndexWriter@c03f38 [junit4] 2> [junit4] 2> 2942416 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: MMapDirectory.UNMAP_SUPPORTED=true [junit4] 2> 2942416 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: flush at getReader [junit4] 2> 2942416 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-9779-thread-1]: startFullFlush [junit4] 2> 2942416 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: apply all deletes during flush [junit4] 2> 2942416 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 2942417 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-9779-thread-1]: prune sis=segments_1: minGen=9223372036854775807 packetCount=0 [junit4] 2> 2942417 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: incRefDeleter for NRT reader version=2 segments= [junit4] 2> 2942417 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: return reader version=2 reader=StandardDirectoryReader(segments_1:2:nrt) [junit4] 2> 2942417 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-9779-thread-1]: coreLoadExecutor-9779-thread-1 finishFullFlush success=true [junit4] 2> 2942418 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-9779-thread-1]: getReader took 2 msec [junit4] 2> 2942420 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1cb68c[collection1] main] [junit4] 2> 2942424 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\conf [junit4] 2> 2942425 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path _rest_managed.json using file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\conf [junit4] 2> 2942425 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed [junit4] 2> 2942425 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path _schema_analysis_stopwords_english.json using file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\conf [junit4] 2> 2942426 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for /schema/analysis/stopwords/english [junit4] 2> 2942426 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for /schema/analysis/stopwords/english [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.ManagedResource Notified 2 observers of /schema/analysis/stopwords/english [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path _schema_analysis_synonyms_english.json using file:dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\conf [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true,format=solr} for /schema/analysis/synonyms/english [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.s.a.ManagedSynonymFilterFactory Loaded 3 synonym mappings for /schema/analysis/synonyms/english [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.r.ManagedResource Notified 2 observers of /schema/analysis/synonyms/english [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01} [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.h.c.SuggestComponent Initializing SuggestComponent [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.s.s.SolrSuggester init: {name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false} [junit4] 2> 2942427 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.s.s.SolrSuggester Dictionary loaded with params: {name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false} [junit4] 2> 2942432 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.h.c.QueryElevationComponent Loading QueryElevation from: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001\tempDir-001\collection1\conf\elevate.xml [junit4] 2> 2942446 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 2942446 INFO (searcherExecutor-9780-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@1cb68c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2942448 INFO (searcherExecutor-9780-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher} hits=0 status=0 QTime=1 [junit4] 2> 2942448 INFO (searcherExecutor-9780-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.QuerySenderListener QuerySenderListener done. [junit4] 2> 2942448 INFO (searcherExecutor-9780-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 2942448 INFO (searcherExecutor-9780-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 2942452 INFO (searcherExecutor-9780-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1cb68c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 2942454 INFO (coreLoadExecutor-9779-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1554656643848863744 [junit4] 2> 2942935 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.SolrJettyTestBase Jetty Assigned Port#60094 [junit4] 2> 2942942 INFO (TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[4A6A87B04A5D7ACA]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSetupJvmMetrics [junit4] 2> 2942949 INFO (TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[4A6A87B04A5D7ACA]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSetupJvmMetrics [junit4] 2> 2942956 INFO (TEST-JvmMetricsTest.testOperatingSystemMetricsSet-seed#[4A6A87B04A5D7ACA]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testOperatingSystemMetricsSet [junit4] 2> 2942982 INFO (TEST-JvmMetricsTest.testOperatingSystemMetricsSet-seed#[4A6A87B04A5D7ACA]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testOperatingSystemMetricsSet [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=JvmMetricsTest -Dtests.method=testOperatingSystemMetricsSet -Dtests.seed=4A6A87B04A5D7ACA -Dtests.slow=true -Dtests.locale=fr-LU -Dtests.timezone=GMT -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 0.04s J1 | JvmMetricsTest.testOperatingSystemMetricsSet <<< [junit4] > Throwable #1: java.lang.AssertionError [junit4] > at __randomizedtesting.SeedInfo.seed([4A6A87B04A5D7ACA:5295E3C5B35B219F]:0) [junit4] > at org.apache.solr.metrics.JvmMetricsTest.testOperatingSystemMetricsSet(JvmMetricsTest.java:51) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 2942987 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@454131{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 2942988 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=29735730 [junit4] 2> 2942989 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@cb7d3b [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: now flush at close [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: start flush: applyAllDeletes=true [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: index before flush [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-9785-thread-1]: startFullFlush [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-9785-thread-1]: coreCloseExecutor-9785-thread-1 finishFullFlush success=true [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: apply all deletes during flush [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-9785-thread-1]: prune sis=segments_1: minGen=9223372036854775807 packetCount=0 [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-9785-thread-1]: initDynamicDefaults spins=false maxThreadCount=2 maxMergeCount=7 [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-9785-thread-1]: updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-9785-thread-1]: now merge [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-9785-thread-1]: index: [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-9785-thread-1]: no more merges pending; now return [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: waitForMerges [junit4] 2> 2942991 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: waitForMerges done [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: commit: start [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: commit: enter lock [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: commit: now prepare [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: prepareCommit: flush [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: index before flush [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-9785-thread-1]: startFullFlush [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: apply all deletes during flush [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-9785-thread-1]: prune sis=segments_1: minGen=9223372036854775807 packetCount=0 [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-9785-thread-1]: coreCloseExecutor-9785-thread-1 finishFullFlush success=true [junit4] 2> 2942992 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: startCommit(): start [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: skip startCommit(): no changes pending [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-9785-thread-1]: delete [] [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: commit: pendingCommit == null; skip [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: commit: took 0.9 msec [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: commit: done [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: rollback [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: all running merges have aborted [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: rollback: done finish merges [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-9785-thread-1]: abort [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-9785-thread-1]: done abort success=true [junit4] 2> 2942993 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-9785-thread-1]: rollback: infos= [junit4] 2> 2942994 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-9785-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 2942994 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-9785-thread-1]: delete [] [junit4] 2> 2942994 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-9785-thread-1]: 0 msec to checkpoint [junit4] 2> 2942994 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-9785-thread-1]: delete [] [junit4] 2> 2943024 INFO (coreCloseExecutor-9785-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 2943024 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 2943026 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@10f43e6{/solr,null,UNAVAILABLE} [junit4] 2> 2943026 INFO (SUITE-JvmMetricsTest-seed#[4A6A87B04A5D7ACA]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.metrics.JvmMetricsTest_4A6A87B04A5D7ACA-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=false): {}, locale=fr-LU, timezone=GMT [junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_112 (32-bit)/cpus=3,threads=1,free=68381496,total=405000192 [junit4] 2> NOTE: All tests run in this JVM: [ConvertedLegacyTest, HdfsChaosMonkeyNothingIsSafeTest, TestBulkSchemaAPI, TestCrossCoreJoin, JavabinLoaderTest, SpellCheckComponentTest, TestJavabinTupleStreamParser, TestEmbeddedSolrServerConstructors, TestFieldTypeCollectionResource, IndexSchemaTest, CdcrReplicationHandlerTest, CdcrVersionReplicationTest, SmileWriterTest, TestTrieFacet, TestConfigSetsAPI, SpellCheckCollatorTest, TestSerializedLuceneMatchVersion, TestBadConfig, TestIndexingPerformance, TestCollapseQParserPlugin, TestXmlQParserPlugin, ParsingFieldUpdateProcessorsTest, ConnectionReuseTest, TestCloudInspectUtil, TestLMJelinekMercerSimilarityFactory, TolerantUpdateProcessorTest, TestTestInjection, TestHdfsCloudBackupRestore, CollectionTooManyReplicasTest, TestReplicationHandlerBackup, TestCloudSchemaless, TestFilteredDocIdSet, AnalysisErrorHandlingTest, TestRequestForwarding, InfoHandlerTest, TestIntervalFaceting, TestDynamicFieldCollectionResource, CollectionReloadTest, SortByFunctionTest, FileBasedSpellCheckerTest, TestMiniSolrCloudCluster, BasicDistributedZk2Test, TestMacros, MultiThreadedOCPTest, SliceStateTest, TestDFRSimilarityFactory, TestUninvertingReader, CreateCollectionCleanupTest, HighlighterConfigTest, TestSolrConfigHandlerConcurrent, BasicAuthIntegrationTest, TestLuceneMatchVersion, SuggesterWFSTTest, TestHdfsUpdateLog, TestJmxMonitoredMap, HLLUtilTest, TestLeaderElectionZkExpiry, FullHLLTest, ShardRoutingCustomTest, HttpSolrCallGetCoreTest, TestSubQueryTransformerDistrib, TestNRTOpen, SolrIndexSplitterTest, QueryResultKeyTest, TestFuzzyAnalyzedSuggestions, TestNonDefinedSimilarityFactory, FieldMutatingUpdateProcessorTest, TestCustomDocTransformer, DistribCursorPagingTest, TestWriterPerf, ResponseLogComponentTest, TestAnalyzedSuggestions, CursorMarkTest, ExitableDirectoryReaderTest, TestFieldCacheWithThreads, ScriptEngineTest, GraphQueryTest, DistributedQueryComponentOptimizationTest, TestSolrDeletionPolicy2, DeleteInactiveReplicaTest, TestAtomicUpdateErrorCases, TestComponentsName, ZkStateReaderTest, SolrCoreMetricManagerTest, HdfsCollectionsAPIDistributedZkTest, DataDrivenBlockJoinTest, FieldAnalysisRequestHandlerTest, BlockCacheTest, TermVectorComponentTest, DeleteShardTest, TestLegacyNumericRangeQueryBuilder, DirectUpdateHandlerOptimizeTest, WrapperMergePolicyFactoryTest, SolrInfoMBeanTest, HdfsBasicDistributedZk2Test, TestDistributedMissingSort, TestFoldingMultitermQuery, TestInfoStreamLogging, SpatialRPTFieldTypeTest, TestConfigOverlay, AsyncCallRequestStatusResponseTest, TestSQLHandlerNonCloud, TestFieldCollectionResource, SuggestComponentContextFilterQueryTest, SolrCloudExampleTest, AutoCommitTest, BlockJoinFacetRandomTest, TestSimpleQParserPlugin, TestMissingGroups, NoCacheHeaderTest, CloudMLTQParserTest, UpdateRequestProcessorFactoryTest, TestUtils, EchoParamsTest, TestHashQParserPlugin, TestFieldCache, TestSystemIdResolver, ConjunctionSolrSpellCheckerTest, TestCloudPseudoReturnFields, TestRTimerTree, SignatureUpdateProcessorFactoryTest, HdfsThreadLeakTest, OpenCloseCoreStressTest, CollectionsAPISolrJTest, TestRandomCollapseQParserPlugin, ClassificationUpdateProcessorTest, TestManagedStopFilterFactory, TestStressRecovery, AliasIntegrationTest, TestRealTimeGet, FullSolrCloudDistribCmdsTest, URLClassifyProcessorTest, TestCodecSupport, LeaderElectionIntegrationTest, DistributedFacetPivotWhiteBoxTest, TestDownShardTolerantSearch, TestPKIAuthenticationPlugin, TemplateUpdateProcessorTest, MetricUtilsTest, DebugComponentTest, ShowFileRequestHandlerTest, TestRestoreCore, ReturnFieldsTest, TestRawResponseWriter, TestSolr4Spatial2, TestSolr4Spatial, TestExactStatsCache, TestSolrCloudWithDelegationTokens, JsonLoaderTest, CleanupOldIndexTest, TestAuthenticationFramework, TestValueSourceCache, CircularListTest, TestConfigReload, TestSchemaNameResource, ClassificationUpdateProcessorFactoryTest, TestRecovery, NotRequiredUniqueKeyTest, SpellPossibilityIteratorTest, ChaosMonkeySafeLeaderTest, UnloadDistributedZkTest, CollectionsAPIDistributedZkTest, BasicZkTest, TestRandomFaceting, LeaderElectionTest, ZkSolrClientTest, TestZkChroot, TestDistributedSearch, TestDistributedGrouping, TestFaceting, TestHashPartitioner, TestStressReorder, TestJoin, TestReload, TestRangeQuery, TestCoreContainer, SolrCmdDistributorTest, PeerSyncTest, BadIndexSchemaTest, TestFiltering, TestIndexSearcher, DistributedQueryElevationComponentTest, SuggesterTSTTest, SuggesterTest, TestStressLucene, TestTrie, SpatialFilterTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, TestWordDelimiterFilterFactory, DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, TestRemoteStreaming, DistanceFunctionTest, TestSolrDeletionPolicy1, XsltUpdateRequestHandlerTest, CacheHeaderTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, TestQueryTypes, PrimitiveFieldTypeTest, TermsComponentTest, DocumentBuilderTest, MoreLikeThisHandlerTest, FastVectorHighlighterTest, RegexBoostProcessorTest, SolrPluginUtilsTest, UniqFieldsUpdateProcessorFactoryTest, TestPHPSerializedResponseWriter, TestLFUCache, TestLMDirichletSimilarityFactory, OpenExchangeRatesOrgProviderTest, DateMathParserTest, PreAnalyzedFieldTest, PrimUtilsTest, TestSuggestSpellingConverter, DateFieldTest, SpellingQueryConverterTest, RAMDirectoryFactoryTest, ClusterStateTest, TestLRUCache, TestDocumentBuilder, SystemInfoHandlerTest, UUIDFieldTest, DistributedMLTComponentTest, TestRTGBase, DistributedIntervalFacetingTest, TestCursorMarkWithoutUniqueKey, TestSimpleTrackingShardHandler, AssignTest, BaseCdcrDistributedZkTest, CdcrBootstrapTest, DeleteStatusTest, DistribJoinFromCollectionTest, ForceLeaderTest, LeaderElectionContextKeyTest, LeaderInitiatedRecoveryOnShardRestartTest, OverriddenZkACLAndCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, OverseerModifyCollectionTest, OverseerStatusTest, OverseerTaskQueueTest, PeerSyncReplicationTest, ReplicationFactorTest, RollingRestartTest, ShardSplitTest, TestOnReconnectListenerSupport, TestReplicaProperties, TestSegmentSorting, TestSolrCloudWithKerberosAlt, TestTolerantUpdateProcessorCloud, TestTolerantUpdateProcessorRandomCloud, VMParamsZkACLAndCredentialsProvidersTest, HdfsNNFailoverTest, HdfsRecoverLeaseTest, HdfsRestartWhileUpdatingTest, HdfsSyncSliceTest, HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, RulesTest, TestImplicitCoreProperties, TestInitParams, TestReloadAndDeleteDocs, TestShardHandlerFactory, TestSolrDynamicMBean, TestSolrXml, TestSolrCloudSnapshots, CoreAdminCreateDiscoverTest, CoreAdminRequestStatusTest, CoreMergeIndexesAdminHandlerTest, SecurityConfHandlerTest, StatsReloadRaceTest, DistributedDebugComponentTest, DistributedFacetPivotLargeTest, DistributedFacetPivotSmallAdvancedTest, FacetPivotSmallTest, ReplicaListTransformerTest, ShufflingReplicaListTransformerTest, SpatialHeatmapFacetsTest, TestUnifiedSolrHighlighter, TestSlowCompositeReaderWrapper, JvmMetricsTest] [junit4] Completed [567/670 (1!)] on J1 in 1.70s, 2 tests, 1 failure <<< FAILURES! [...truncated 54868 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org