Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6306/ 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.NullPointerException at __randomizedtesting.SeedInfo.seed([7DAFA6C7A4EA4D17:6550C2B25DEC1642]:0) at org.apache.solr.metrics.JvmMetricsTest.testOperatingSystemMetricsSet(JvmMetricsTest.java:50) 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 11333 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_7DAFA6C7A4EA4D17-001\init-core-data-001 [junit4] 2> 859922 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) [junit4] 2> 860223 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 860223 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 860225 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-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_7DAFA6C7A4EA4D17-001\tempDir-002\cores\core [junit4] 2> 860233 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.e.j.s.Server jetty-9.3.14.v20161028 [junit4] 2> 860235 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@33677168{/solr,null,AVAILABLE} [junit4] 2> 860244 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConnector@54d45bc2{SSL,[ssl, http/1.1]}{127.0.0.1:52278} [junit4] 2> 860244 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.e.j.s.Server Started @866233ms [junit4] 2> 860244 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52278, configSetBaseDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_7DAFA6C7A4EA4D17-001\tempDir-001, coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_7DAFA6C7A4EA4D17-001\tempDir-002\cores} [junit4] 2> 860245 ERROR (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 860245 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.0.0 [junit4] 2> 860245 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 860245 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 860245 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-12-23T20:46:55.705Z [junit4] 2> 860246 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-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_7DAFA6C7A4EA4D17-001\tempDir-001\solr.xml [junit4] 2> 860301 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-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_7DAFA6C7A4EA4D17-001\tempDir-001 [junit4] 2> 860301 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 860393 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib [junit4] 2> 860395 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 860396 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib [junit4] 2> 860397 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 860398 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib [junit4] 2> 860398 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 860399 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\contrib\ltr\lib [junit4] 2> 860399 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 860401 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib [junit4] 2> 860401 WARN (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\..\..\..\..\dist [junit4] 2> 860412 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is enabled [junit4] 2> 860414 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0 [junit4] 2> 860481 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example [junit4] 2> 860985 INFO (coreLoadExecutor-3796-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> 860985 INFO (coreLoadExecutor-3796-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> 860993 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id [junit4] 2> 860993 INFO (coreLoadExecutor-3796-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> 860993 INFO (coreLoadExecutor-3796-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> 861066 INFO (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1 [junit4] 2> 861066 INFO (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\data\] [junit4] 2> 861067 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@61ec0ea4 [junit4] 2> 861069 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: init: current segments file is "segments"; deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@2c1d475b [junit4] 2> 861069 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: delete [] [junit4] 2> 861069 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 861069 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: delete [] [junit4] 2> 861069 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: 0 msec to checkpoint [junit4] 2> 861069 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: init: create=true [junit4] 2> 861069 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: [junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@41500141 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@621f413c) [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@4bbdabc9 [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@a26e1f6 [junit4] 2> [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: MMapDirectory.UNMAP_SUPPORTED=true [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: now flush at close [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: start flush: applyAllDeletes=true [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: index before flush [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-3796-thread-1]: startFullFlush [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-3796-thread-1]: coreLoadExecutor-3796-thread-1 finishFullFlush success=true [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: apply all deletes during flush [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-3796-thread-1]: prune sis=segments: minGen=9223372036854775807 packetCount=0 [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-3796-thread-1]: initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6 [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-3796-thread-1]: updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-3796-thread-1]: now merge [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-3796-thread-1]: index: [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-3796-thread-1]: no more merges pending; now return [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: waitForMerges [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: waitForMerges done [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: commit: start [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: commit: enter lock [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: commit: now prepare [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: prepareCommit: flush [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: index before flush [junit4] 2> 861070 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-3796-thread-1]: startFullFlush [junit4] 2> 861071 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: apply all deletes during flush [junit4] 2> 861071 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 861071 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-3796-thread-1]: prune sis=segments: minGen=9223372036854775807 packetCount=0 [junit4] 2> 861071 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-3796-thread-1]: coreLoadExecutor-3796-thread-1 finishFullFlush success=true [junit4] 2> 861071 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: startCommit(): start [junit4] 2> 861071 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: startCommit index= changeCount=2 [junit4] 2> 861071 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: startCommit: wrote pending segments file "pending_segments_1" [junit4] 2> 861071 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: done all syncs: [] [junit4] 2> 861071 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: commit: pendingCommit != null [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: commit: done writing segments file "segments_1" [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: now checkpoint "" [0 segments ; isCommit = true] [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: 0 msec to checkpoint [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: delete [] [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: commit: took 0.9 msec [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: commit: done [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: rollback [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: all running merges have aborted [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: rollback: done finish merges [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-3796-thread-1]: abort [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-3796-thread-1]: done abort success=true [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: rollback: infos= [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: delete [] [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: 0 msec to checkpoint [junit4] 2> 861072 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: delete [] [junit4] 2> 861140 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5 [junit4] 2> 861537 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 861537 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 861541 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms; [junit4] 2> 861541 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 861541 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: init: current segments file is "segments_1"; deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@2c1d475b [junit4] 2> 861541 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: init: load commit "segments_1" [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: delete [] [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: delete [] [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-3796-thread-1]: 0 msec to checkpoint [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: init: create=false [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: [junit4] 2> dir=MockDirectoryWrapper(RAMDirectory@41500141 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@621f413c) [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@15c2de5a [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@6cfcfa1d [junit4] 2> [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: MMapDirectory.UNMAP_SUPPORTED=true [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: flush at getReader [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-3796-thread-1]: startFullFlush [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: apply all deletes during flush [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-3796-thread-1]: prune sis=segments_1: minGen=9223372036854775807 packetCount=0 [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: incRefDeleter for NRT reader version=2 segments= [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: return reader version=2 reader=StandardDirectoryReader(segments_1:2:nrt) [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-3796-thread-1]: coreLoadExecutor-3796-thread-1 finishFullFlush success=true [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-3796-thread-1]: getReader took 0 msec [junit4] 2> 861542 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@58cc5c97[collection1] main] [junit4] 2> 861544 INFO (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\conf [junit4] 2> 861545 INFO (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\conf [junit4] 2> 861545 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed [junit4] 2> 861545 INFO (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\conf [junit4] 2> 861545 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for /schema/analysis/stopwords/english [junit4] 2> 861545 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for /schema/analysis/stopwords/english [junit4] 2> 861545 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.r.ManagedResource Notified 2 observers of /schema/analysis/stopwords/english [junit4] 2> 861551 INFO (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\conf [junit4] 2> 861551 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true,format=solr} for /schema/analysis/synonyms/english [junit4] 2> 861551 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.r.s.a.ManagedSynonymFilterFactory Loaded 3 synonym mappings for /schema/analysis/synonyms/english [junit4] 2> 861551 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.r.ManagedResource Notified 2 observers of /schema/analysis/synonyms/english [junit4] 2> 861552 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 861697 INFO (coreLoadExecutor-3796-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> 861697 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.h.c.SuggestComponent Initializing SuggestComponent [junit4] 2> 861717 INFO (coreLoadExecutor-3796-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> 861969 INFO (coreLoadExecutor-3796-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> 861970 INFO (coreLoadExecutor-3796-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_7DAFA6C7A4EA4D17-001\tempDir-001\collection1\conf\elevate.xml [junit4] 2> 862064 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 862065 INFO (searcherExecutor-3797-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@58cc5c97[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 862067 INFO (coreLoadExecutor-3796-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1554541201354391552 [junit4] 2> 862075 INFO (searcherExecutor-3797-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> 862075 INFO (searcherExecutor-3797-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.QuerySenderListener QuerySenderListener done. [junit4] 2> 862075 INFO (searcherExecutor-3797-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 862075 INFO (searcherExecutor-3797-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 862076 INFO (searcherExecutor-3797-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@58cc5c97[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 862196 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.SolrJettyTestBase Jetty Assigned Port#52278 [junit4] 2> 862206 INFO (TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[7DAFA6C7A4EA4D17]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSetupJvmMetrics [junit4] 2> 862214 INFO (TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[7DAFA6C7A4EA4D17]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSetupJvmMetrics [junit4] 2> 862225 INFO (TEST-JvmMetricsTest.testOperatingSystemMetricsSet-seed#[7DAFA6C7A4EA4D17]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testOperatingSystemMetricsSet [junit4] 2> 862231 INFO (TEST-JvmMetricsTest.testOperatingSystemMetricsSet-seed#[7DAFA6C7A4EA4D17]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testOperatingSystemMetricsSet [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=JvmMetricsTest -Dtests.method=testOperatingSystemMetricsSet -Dtests.seed=7DAFA6C7A4EA4D17 -Dtests.slow=true -Dtests.locale=es-PY -Dtests.timezone=Asia/Macau -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.02s J0 | JvmMetricsTest.testOperatingSystemMetricsSet <<< [junit4] > Throwable #1: java.lang.NullPointerException [junit4] > at __randomizedtesting.SeedInfo.seed([7DAFA6C7A4EA4D17:6550C2B25DEC1642]:0) [junit4] > at org.apache.solr.metrics.JvmMetricsTest.testOperatingSystemMetricsSet(JvmMetricsTest.java:50) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 862237 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@54d45bc2{SSL,[ssl, http/1.1]}{127.0.0.1:0} [junit4] 2> 862237 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1488984200 [junit4] 2> 862238 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@16290550 [junit4] 2> 862239 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: now flush at close [junit4] 2> 862239 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: start flush: applyAllDeletes=true [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: index before flush [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3802-thread-1]: startFullFlush [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3802-thread-1]: coreCloseExecutor-3802-thread-1 finishFullFlush success=true [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: apply all deletes during flush [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-3802-thread-1]: prune sis=segments_1: minGen=9223372036854775807 packetCount=0 [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-3802-thread-1]: initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6 [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-3802-thread-1]: updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-3802-thread-1]: now merge [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-3802-thread-1]: index: [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-3802-thread-1]: no more merges pending; now return [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: waitForMerges [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: waitForMerges done [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: commit: start [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: commit: enter lock [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: commit: now prepare [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: prepareCommit: flush [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: index before flush [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3802-thread-1]: startFullFlush [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: apply all deletes during flush [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: now apply all deletes for all segments maxDoc=0 [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-3802-thread-1]: prune sis=segments_1: minGen=9223372036854775807 packetCount=0 [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3802-thread-1]: coreCloseExecutor-3802-thread-1 finishFullFlush success=true [junit4] 2> 862240 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: startCommit(): start [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: skip startCommit(): no changes pending [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-3802-thread-1]: delete [] [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: commit: pendingCommit == null; skip [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: commit: took 0.5 msec [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: commit: done [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: rollback [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: all running merges have aborted [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: rollback: done finish merges [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3802-thread-1]: abort [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-3802-thread-1]: done abort success=true [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-3802-thread-1]: rollback: infos= [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-3802-thread-1]: now checkpoint "" [0 segments ; isCommit = false] [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-3802-thread-1]: delete [] [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-3802-thread-1]: 0 msec to checkpoint [junit4] 2> 862241 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-3802-thread-1]: delete [] [junit4] 2> 862267 INFO (coreCloseExecutor-3802-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1 [junit4] 2> 862268 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node [junit4] 2> 862269 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@33677168{/solr,null,UNAVAILABLE} [junit4] 2> 862271 INFO (SUITE-JvmMetricsTest-seed#[7DAFA6C7A4EA4D17]-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_7DAFA6C7A4EA4D17-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1487, maxMBSortInHeap=7.4060033179057365, sim=RandomSimilarity(queryNorm=true): {}, locale=es-PY, timezone=Asia/Macau [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_112 (64-bit)/cpus=3,threads=1,free=332070832,total=497025024 [junit4] 2> NOTE: All tests run in this JVM: [HdfsTlogReplayBufferedWhileIndexingTest, TestCollationFieldDocValues, TestSurroundQueryParser, DistributedMLTComponentTest, RecoveryAfterSoftCommitTest, TestSortByMinMaxFunction, ConnectionManagerTest, TestSort, TestFieldCacheVsDocValues, PathHierarchyTokenizerFactoryTest, StandardRequestHandlerTest, TestSolrCloudWithKerberosAlt, TestHashPartitioner, PrimUtilsTest, BigEndianAscendingWordSerializerTest, QueryEqualityTest, UniqFieldsUpdateProcessorFactoryTest, IndexBasedSpellCheckerTest, TestDefaultStatsCache, CdcrUpdateLogTest, OverseerTaskQueueTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, SpatialHeatmapFacetsTest, TestRemoteStreaming, SimplePostToolTest, TestExclusionRuleCollectionAccess, TestFieldTypeResource, ExplicitHLLTest, TestExportWriter, DateFieldTest, TestLFUCache, TestGraphTermsQParserPlugin, TestQuerySenderNoQuery, TestMaxScoreQueryParser, TestSchemaManager, HdfsSyncSliceTest, SyncSliceTest, TestReplicationHandler, DirectUpdateHandlerTest, TestCSVResponseWriter, TestDocTermOrds, SSLMigrationTest, RuleEngineTest, DistributedQueryElevationComponentTest, TestCoreContainer, UnloadDistributedZkTest, TestTrackingShardHandlerFactory, TestReqParamsAPI, TestPushWriter, TestSolrQueryParserDefaultOperatorResource, TestManagedSynonymFilterFactory, TestHighlightDedupGrouping, OverseerRolesTest, HdfsWriteToMultipleCollectionsTest, AnalyticsQueryTest, DeleteLastCustomShardedReplicaTest, TestAuthorizationFramework, SegmentsInfoRequestHandlerTest, TestSQLHandler, TestSchemaResource, XsltUpdateRequestHandlerTest, TestCollectionAPI, TestSolrXml, PreAnalyzedUpdateProcessorTest, TestXIncludeConfig, BaseCdcrDistributedZkTest, SynonymTokenizerTest, TestSmileRequest, BlockJoinFacetSimpleTest, DateRangeFieldTest, TestWordDelimiterFilterFactory, TestJmxIntegration, BinaryUpdateRequestHandlerTest, ShardRoutingTest, TestSolrCoreSnapshots, DocValuesNotIndexedTest, TestBinaryField, MBeansHandlerTest, UUIDUpdateProcessorFallbackTest, TestRandomRequestDistribution, TestSweetSpotSimilarityFactory, TestReplicaProperties, CdcrRequestHandlerTest, TestCollationField, TestRequestStatusCollectionAPI, PrimitiveFieldTypeTest, CopyFieldTest, DeleteReplicaTest, IndexSchemaRuntimeFieldTest, HdfsBasicDistributedZkTest, RestartWhileUpdatingTest, FastVectorHighlighterTest, DirectoryFactoryTest, PingRequestHandlerTest, LeaderElectionTest, TestConfigSets, TestExtendedDismaxParser, SuggesterFSTTest, TestLockTree, TestSizeLimitedDistributedMap, SharedFSAutoReplicaFailoverUtilsTest, JvmMetricsTest] [junit4] Completed [215/670 (1!)] on J0 in 2.38s, 2 tests, 1 error <<< FAILURES! [...truncated 63924 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org