Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6314/ Java: 64bit/jdk1.8.0_112 -XX:+UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.metrics.JvmMetricsTest.testOperatingSystemMetricsSet Error Message: Stack Trace: java.lang.AssertionError at __randomizedtesting.SeedInfo.seed([E0D730E989E0FC75:F828549C70E6A720]: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 10825 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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\init-core-data-001 [junit4] 2> 356027 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-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> 356329 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 356329 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 356330 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-002\cores\core [junit4] 2> 356335 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 356336 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3566b3e1{/solr,null,AVAILABLE} [junit4] 2> 356338 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@f32040e{HTTP/1.1,[http/1.1]}{127.0.0.1:61640} [junit4] 2> 356338 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.e.j.s.Server Started @361195ms [junit4] 2> 356338 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=61640, configSetBaseDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-002\cores} [junit4] 2> 356338 ERROR (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 356338 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 356338 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 356338 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 356339 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-27T04:40:53.425Z [junit4] 2> 356339 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\solr.xml [junit4] 2> 356369 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001 [junit4] 2> 356369 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 356395 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib [junit4] 2> 356396 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 356397 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib [junit4] 2> 356397 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 356398 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib [junit4] 2> 356398 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 356399 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\contrib\ltr\lib [junit4] 2> 356399 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 356400 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib [junit4] 2> 356400 WARN (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 356406 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is enabled [junit4] 2> 356408 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 356446 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example [junit4] 2> 357276 INFO (coreLoadExecutor-986-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> 357279 INFO (coreLoadExecutor-986-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> 357295 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id [junit4] 2> 357295 INFO (coreLoadExecutor-986-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> 357295 INFO (coreLoadExecutor-986-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> 357345 INFO (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1 [junit4] 2> 357345 INFO (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\data\] [junit4] 2> 357345 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@343bbcdc [junit4] 2> 357394 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: init: current segments file is "segments"; deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@693d8280 [junit4] 2> 357394 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: delete [] [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: delete [] [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: 0 msec to checkpoint [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: init: create=true [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: [junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@7f3efb30 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c1a904) [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@1558a444 [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@1db72aa4 [junit4] 2> [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: MMapDirectory.UNMAP_SUPPORTED=true [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: now flush at close [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: start flush: applyAllDeletes=true [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: index before flush [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-986-thread-1]: startFullFlush [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-986-thread-1]: coreLoadExecutor-986-thread-1 finishFullFlush success=true [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: apply all deletes during flush [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 357395 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-986-thread-1]: prune sis=segments: minGen=9223372036854775807 packetCount=0 [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-986-thread-1]: initDynamicDefaults spins=true maxThreadCount=1 maxMergeCount=6 [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-986-thread-1]: updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-986-thread-1]: now merge [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-986-thread-1]: index: [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-986-thread-1]: no more merges pending; now return [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: waitForMerges [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: waitForMerges done [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: commit: start [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: commit: enter lock [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: commit: now prepare [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: prepareCommit: flush [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: index before flush [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-986-thread-1]: startFullFlush [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: apply all deletes during flush [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-986-thread-1]: prune sis=segments: minGen=9223372036854775807 packetCount=0 [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-986-thread-1]: coreLoadExecutor-986-thread-1 finishFullFlush success=true [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: startCommit(): start [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: startCommit index= changeCount=2 [junit4] 2> 357396 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: startCommit: wrote pending segments file "pending_segments_1" [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: done all syncs: [] [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: commit: pendingCommit != null [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: commit: done writing segments file "segments_1" [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: now checkpoint "" [0 segments ; isCommit = true] [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: 0 msec to checkpoint [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: delete [] [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: commit: took 1.3 msec [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: commit: done [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: rollback [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: all running merges have aborted [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: rollback: done finish merges [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-986-thread-1]: abort [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-986-thread-1]: done abort success=true [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: rollback: infos= [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: delete [] [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: 0 msec to checkpoint [junit4] 2> 357398 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: delete [] [junit4] 2> 357485 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5 [junit4] 2> 357689 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 357689 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 357691 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; [junit4] 2> 357691 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 357691 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: init: current segments file is "segments_1"; deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@693d8280 [junit4] 2> 357691 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: init: load commit "segments_1" [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: delete [] [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: delete [] [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-986-thread-1]: 0 msec to checkpoint [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: init: create=false [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: [junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@7f3efb30 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@c1a904) [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@e706b60 [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@644b661b [junit4] 2> [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: MMapDirectory.UNMAP_SUPPORTED=true [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: flush at getReader [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-986-thread-1]: startFullFlush [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: apply all deletes during flush [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-986-thread-1]: prune sis=segments_1: minGen=9223372036854775807 packetCount=0 [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: incRefDeleter for NRT reader version=2 segments= [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: return reader version=2 reader=StandardDirectoryReader(segments_1:2:nrt) [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-986-thread-1]: coreLoadExecutor-986-thread-1 finishFullFlush success=true [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-986-thread-1]: getReader took 0 msec [junit4] 2> 357692 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@66ac24d1[collection1] main] [junit4] 2> 357694 INFO (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\conf [junit4] 2> 357695 INFO (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\conf [junit4] 2> 357695 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed [junit4] 2> 357696 INFO (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\conf [junit4] 2> 357696 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for /schema/analysis/stopwords/english [junit4] 2> 357696 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for /schema/analysis/stopwords/english [junit4] 2> 357696 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.r.ManagedResource Notified 2 observers of /schema/analysis/stopwords/english [junit4] 2> 357697 INFO (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\conf [junit4] 2> 357697 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true,format=solr} for /schema/analysis/synonyms/english [junit4] 2> 357700 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.r.s.a.ManagedSynonymFilterFactory Loaded 3 synonym mappings for /schema/analysis/synonyms/english [junit4] 2> 357706 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.r.ManagedResource Notified 2 observers of /schema/analysis/synonyms/english [junit4] 2> 357706 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 357754 INFO (coreLoadExecutor-986-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> 357755 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.h.c.SuggestComponent Initializing SuggestComponent [junit4] 2> 357755 INFO (coreLoadExecutor-986-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> 357894 INFO (coreLoadExecutor-986-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> 357909 INFO (coreLoadExecutor-986-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001\tempDir-001\collection1\conf\elevate.xml [junit4] 2> 357968 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 357968 INFO (searcherExecutor-987-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@66ac24d1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 357973 INFO (coreLoadExecutor-986-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1554842811168194560 [junit4] 2> 357976 INFO (searcherExecutor-987-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> 357976 INFO (searcherExecutor-987-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.QuerySenderListener QuerySenderListener done. [junit4] 2> 357976 INFO (searcherExecutor-987-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 357976 INFO (searcherExecutor-987-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 357976 INFO (searcherExecutor-987-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@66ac24d1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 358420 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.SolrJettyTestBase Jetty Assigned Port#61640 [junit4] 2> 358424 INFO (TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[E0D730E989E0FC75]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSetupJvmMetrics [junit4] 2> 358433 INFO (TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[E0D730E989E0FC75]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSetupJvmMetrics [junit4] 2> 358438 INFO (TEST-JvmMetricsTest.testOperatingSystemMetricsSet-seed#[E0D730E989E0FC75]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testOperatingSystemMetricsSet [junit4] 2> 358760 INFO (TEST-JvmMetricsTest.testOperatingSystemMetricsSet-seed#[E0D730E989E0FC75]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testOperatingSystemMetricsSet [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=JvmMetricsTest -Dtests.method=testOperatingSystemMetricsSet -Dtests.seed=E0D730E989E0FC75 -Dtests.slow=true -Dtests.locale=sr -Dtests.timezone=US/Aleutian -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] FAILURE 0.33s J0 | JvmMetricsTest.testOperatingSystemMetricsSet <<< [junit4] > Throwable #1: java.lang.AssertionError [junit4] > at __randomizedtesting.SeedInfo.seed([E0D730E989E0FC75:F828549C70E6A720]:0) [junit4] > at org.apache.solr.metrics.JvmMetricsTest.testOperatingSystemMetricsSet(JvmMetricsTest.java:51) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 358767 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@f32040e{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 358767 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=410976749 [junit4] 2> 358768 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5c637f19 [junit4] 2> 358769 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: now flush at close [junit4] 2> 358769 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: start flush: applyAllDeletes=true [junit4] 2> 358769 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: index before flush [junit4] 2> 358769 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-992-thread-1]: startFullFlush [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-992-thread-1]: coreCloseExecutor-992-thread-1 finishFullFlush success=true [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: apply all deletes during flush [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-992-thread-1]: prune sis=segments_1: minGen=9223372036854775807 packetCount=0 [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-992-thread-1]: initDynamicDefaults spins=true maxThreadCount=1 maxMergeCount=6 [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-992-thread-1]: updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-992-thread-1]: now merge [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-992-thread-1]: index: [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-992-thread-1]: no more merges pending; now return [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: waitForMerges [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: waitForMerges done [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: commit: start [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: commit: enter lock [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: commit: now prepare [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: prepareCommit: flush [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: index before flush [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-992-thread-1]: startFullFlush [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: apply all deletes during flush [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-992-thread-1]: prune sis=segments_1: minGen=9223372036854775807 packetCount=0 [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-992-thread-1]: coreCloseExecutor-992-thread-1 finishFullFlush success=true [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: startCommit(): start [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: skip startCommit(): no changes pending [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-992-thread-1]: delete [] [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: commit: pendingCommit == null; skip [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: commit: took 0.3 msec [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: commit: done [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: rollback [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: all running merges have aborted [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: rollback: done finish merges [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-992-thread-1]: abort [junit4] 2> 358770 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-992-thread-1]: done abort success=true [junit4] 2> 358771 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-992-thread-1]: rollback: infos= [junit4] 2> 358771 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-992-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 358771 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-992-thread-1]: delete [] [junit4] 2> 358771 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-992-thread-1]: 0 msec to checkpoint [junit4] 2> 358771 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-992-thread-1]: delete [] [junit4] 2> 358804 INFO (coreCloseExecutor-992-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 358807 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 358810 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3566b3e1{/solr,null,UNAVAILABLE} [junit4] 2> 358814 INFO (SUITE-JvmMetricsTest-seed#[E0D730E989E0FC75]-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\J0\temp\solr.metrics.JvmMetricsTest_E0D730E989E0FC75-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1290, maxMBSortInHeap=6.009768027896935, sim=RandomSimilarity(queryNorm=false): {}, locale=sr, timezone=US/Aleutian [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_112 (64-bit)/cpus=3,threads=1,free=82879400,total=536870912 [junit4] 2> NOTE: All tests run in this JVM: [DistribDocExpirationUpdateProcessorTest, ReplicaListTransformerTest, TestExtendedDismaxParser, TestStressCloudBlindAtomicUpdates, TestBulkSchemaConcurrent, HdfsChaosMonkeySafeLeaderTest, HdfsNNFailoverTest, TestFileDictionaryLookup, SimpleFacetsTest, BinaryUpdateRequestHandlerTest, TestFastLRUCache, OverseerTest, BasicDistributedZkTest, LeaderInitiatedRecoveryOnCommitTest, OverseerRolesTest, DistributedQueueTest, RuleEngineTest, TestSolrCloudWithKerberosAlt, TestSegmentSorting, TestXIncludeConfig, TestUpdate, JvmMetricsTest] [junit4] Completed [60/670 (1!)] on J0 in 2.82s, 2 tests, 1 failure <<< FAILURES! [...truncated 64417 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org