Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6304/
Java: 32bit/jdk1.8.0_112 -server -XX:+UseConcMarkSweepGC

2 tests failed.
FAILED:  
org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail

Error Message:
expected:<200> but was:<404>

Stack Trace:
java.lang.AssertionError: expected:<200> but was:<404>
        at 
__randomizedtesting.SeedInfo.seed([7EB35D04A4261AD0:160C682E74BC083C]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at org.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.cancelDelegationToken(TestSolrCloudWithDelegationTokens.java:140)
        at 
org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail(TestSolrCloudWithDelegationTokens.java:294)
        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)


FAILED:  org.apache.solr.metrics.JvmMetricsTest.testOperatingSystemMetricsSet

Error Message:


Stack Trace:
java.lang.NullPointerException
        at 
__randomizedtesting.SeedInfo.seed([7EB35D04A4261AD0:664C39715D204185]: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 10931 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_7EB35D04A4261AD0-001\init-core-data-001
   [junit4]   2> 364905 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-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> 365318 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 365318 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 365320 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-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_7EB35D04A4261AD0-001\tempDir-002\cores\core
   [junit4]   2> 365327 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 365328 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@158d675{/solr,null,AVAILABLE}
   [junit4]   2> 365329 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@460342{HTTP/1.1,[http/1.1]}{127.0.0.1:52802}
   [junit4]   2> 365329 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] o.e.j.s.Server 
Started @371004ms
   [junit4]   2> 365330 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=52802, 
configSetBaseDir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_7EB35D04A4261AD0-001\tempDir-001,
 
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_7EB35D04A4261AD0-001\tempDir-002\cores}
   [junit4]   2> 365330 ERROR 
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 365330 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 365330 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 365330 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 365330 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-12-23T00:41:57.558Z
   [junit4]   2> 365330 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-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_7EB35D04A4261AD0-001\tempDir-001\solr.xml
   [junit4]   2> 365385 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-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_7EB35D04A4261AD0-001\tempDir-001
   [junit4]   2> 365385 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 365438 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\contrib\extraction\lib
   [junit4]   2> 365448 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\dist
   [junit4]   2> 365450 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\contrib\clustering\lib
   [junit4]   2> 365452 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\dist
   [junit4]   2> 365455 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\contrib\langid\lib
   [junit4]   2> 365457 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\dist
   [junit4]   2> 365458 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\contrib\ltr\lib
   [junit4]   2> 365459 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\dist
   [junit4]   2> 365460 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\contrib\velocity\lib
   [junit4]   2> 365461 WARN  (coreLoadExecutor-819-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_7EB35D04A4261AD0-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_7EB35D04A4261AD0-001\tempDir-001\collection1\..\..\..\..\dist
   [junit4]   2> 365481 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is 
enabled
   [junit4]   2> 365484 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 365547 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 366297 INFO  (coreLoadExecutor-819-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> 366300 INFO  (coreLoadExecutor-819-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> 366310 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 366310 INFO  (coreLoadExecutor-819-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> 366310 INFO  (coreLoadExecutor-819-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> 366360 INFO  (coreLoadExecutor-819-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_7EB35D04A4261AD0-001\tempDir-001\collection1
   [junit4]   2> 366361 INFO  (coreLoadExecutor-819-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_7EB35D04A4261AD0-001\tempDir-001\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.metrics.JvmMetricsTest_7EB35D04A4261AD0-001\tempDir-001\collection1\data\]
   [junit4]   2> 366361 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7784e7
   [junit4]   2> 366410 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
init: current segments file is "segments"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@66b675
   [junit4]   2> 366410 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
delete []
   [junit4]   2> 366410 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 366410 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
delete []
   [junit4]   2> 366410 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 366410 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
init: create=true
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@973df9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f39d6)
   [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@92384f
   [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@1eda4d1
   [junit4]   2> 
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
now flush at close
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]:   
start flush: applyAllDeletes=true
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]:   
index before flush 
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-819-thread-1]: 
startFullFlush
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-819-thread-1]: 
coreLoadExecutor-819-thread-1 finishFullFlush success=true
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
apply all deletes during flush
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-819-thread-1]: 
prune sis=segments:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-819-thread-1]: 
initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-819-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-819-thread-1]: 
now merge
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-819-thread-1]:   
index: 
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-819-thread-1]:   
no more merges pending; now return
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
waitForMerges
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
waitForMerges done
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
commit: start
   [junit4]   2> 366411 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
commit: enter lock
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
commit: now prepare
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
prepareCommit: flush
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]:   
index before flush 
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-819-thread-1]: 
startFullFlush
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
apply all deletes during flush
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-819-thread-1]: 
prune sis=segments:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-819-thread-1]: 
coreLoadExecutor-819-thread-1 finishFullFlush success=true
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
startCommit(): start
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
startCommit index= changeCount=2
   [junit4]   2> 366412 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
startCommit: wrote pending segments file "pending_segments_1"
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
done all syncs: []
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
commit: pendingCommit != null
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
commit: done writing segments file "segments_1"
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
now checkpoint "" [0 segments ; isCommit = true]
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
delete []
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
commit: took 1.5 msec
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
commit: done
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
rollback
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
all running merges have aborted
   [junit4]   2> 366413 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
rollback: done finish merges
   [junit4]   2> 366414 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-819-thread-1]: 
abort
   [junit4]   2> 366414 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-819-thread-1]: 
done abort success=true
   [junit4]   2> 366414 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
rollback: infos=
   [junit4]   2> 366414 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 366414 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
delete []
   [junit4]   2> 366414 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 366414 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
delete []
   [junit4]   2> 366498 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
   [junit4]   2> 366710 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 366710 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 366712 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 
15000ms; 
   [junit4]   2> 366712 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 366714 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
init: current segments file is "segments_1"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@66b675
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
init: load commit "segments_1"
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
delete []
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
delete []
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-819-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
init: create=false
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@973df9 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@f39d6)
   [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@145065
   [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@936786
   [junit4]   2> 
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
flush at getReader
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-819-thread-1]: 
startFullFlush
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
apply all deletes during flush
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-819-thread-1]: 
prune sis=segments_1:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 366715 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
incRefDeleter for NRT reader version=2 segments=
   [junit4]   2> 366725 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
return reader version=2 reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 366727 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-819-thread-1]: 
coreLoadExecutor-819-thread-1 finishFullFlush success=true
   [junit4]   2> 366728 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-819-thread-1]: 
getReader took 13 msec
   [junit4]   2> 366728 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@b44598[collection1] 
main]
   [junit4]   2> 366758 INFO  (coreLoadExecutor-819-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_7EB35D04A4261AD0-001\tempDir-001\collection1\conf
   [junit4]   2> 366758 INFO  (coreLoadExecutor-819-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_7EB35D04A4261AD0-001\tempDir-001\collection1\conf
   [junit4]   2> 366758 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed
   [junit4]   2> 366770 INFO  (coreLoadExecutor-819-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_7EB35D04A4261AD0-001\tempDir-001\collection1\conf
   [junit4]   2> 366770 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for 
/schema/analysis/stopwords/english
   [junit4]   2> 366770 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for 
/schema/analysis/stopwords/english
   [junit4]   2> 366770 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 2 observers of 
/schema/analysis/stopwords/english
   [junit4]   2> 366771 INFO  (coreLoadExecutor-819-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_7EB35D04A4261AD0-001\tempDir-001\collection1\conf
   [junit4]   2> 366771 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs 
{ignoreCase=true,format=solr} for /schema/analysis/synonyms/english
   [junit4]   2> 366774 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.r.s.a.ManagedSynonymFilterFactory Loaded 3 synonym 
mappings for /schema/analysis/synonyms/english
   [junit4]   2> 366778 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 2 observers of 
/schema/analysis/synonyms/english
   [junit4]   2> 366778 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 366779 INFO  (coreLoadExecutor-819-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> 366779 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.h.c.SuggestComponent Initializing SuggestComponent
   [junit4]   2> 366779 INFO  (coreLoadExecutor-819-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> 366779 INFO  (coreLoadExecutor-819-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> 366780 INFO  (coreLoadExecutor-819-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_7EB35D04A4261AD0-001\tempDir-001\collection1\conf\elevate.xml
   [junit4]   2> 366874 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 366877 INFO  
(searcherExecutor-820-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@b44598[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 366887 INFO  
(searcherExecutor-820-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=3
   [junit4]   2> 366888 INFO  
(searcherExecutor-820-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 366888 INFO  
(searcherExecutor-820-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 366888 INFO  
(searcherExecutor-820-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 366895 INFO  
(searcherExecutor-820-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@b44598[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 366904 INFO  (coreLoadExecutor-819-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1554465390992556032
   [junit4]   2> 366996 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.SolrJettyTestBase Jetty Assigned Port#52802
   [junit4]   2> 367000 INFO  
(TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[7EB35D04A4261AD0]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testSetupJvmMetrics
   [junit4]   2> 367034 INFO  
(TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[7EB35D04A4261AD0]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testSetupJvmMetrics
   [junit4]   2> 367039 INFO  
(TEST-JvmMetricsTest.testOperatingSystemMetricsSet-seed#[7EB35D04A4261AD0]) [   
 ] o.a.s.SolrTestCaseJ4 ###Starting testOperatingSystemMetricsSet
   [junit4]   2> 367057 INFO  
(TEST-JvmMetricsTest.testOperatingSystemMetricsSet-seed#[7EB35D04A4261AD0]) [   
 ] o.a.s.SolrTestCaseJ4 ###Ending testOperatingSystemMetricsSet
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=JvmMetricsTest 
-Dtests.method=testOperatingSystemMetricsSet -Dtests.seed=7EB35D04A4261AD0 
-Dtests.slow=true -Dtests.locale=ar-JO -Dtests.timezone=Africa/Windhoek 
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.03s J0 | JvmMetricsTest.testOperatingSystemMetricsSet <<<
   [junit4]    > Throwable #1: java.lang.NullPointerException
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([7EB35D04A4261AD0:664C39715D204185]:0)
   [junit4]    >        at 
org.apache.solr.metrics.JvmMetricsTest.testOperatingSystemMetricsSet(JvmMetricsTest.java:50)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 367063 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@460342{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 367063 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1935114
   [junit4]   2> 367064 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@ff9b11
   [junit4]   2> 367066 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
now flush at close
   [junit4]   2> 367066 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]:  
 start flush: applyAllDeletes=true
   [junit4]   2> 367066 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]:  
 index before flush 
   [junit4]   2> 367066 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-825-thread-1]: 
startFullFlush
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-825-thread-1]: 
coreCloseExecutor-825-thread-1 finishFullFlush success=true
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
apply all deletes during flush
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-825-thread-1]: 
prune sis=segments_1:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-825-thread-1]: 
initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-825-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-825-thread-1]: 
now merge
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-825-thread-1]:  
 index: 
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-825-thread-1]:  
 no more merges pending; now return
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
waitForMerges
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
waitForMerges done
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
commit: start
   [junit4]   2> 367067 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
commit: enter lock
   [junit4]   2> 367068 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
commit: now prepare
   [junit4]   2> 367068 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
prepareCommit: flush
   [junit4]   2> 367068 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]:  
 index before flush 
   [junit4]   2> 367068 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-825-thread-1]: 
startFullFlush
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
apply all deletes during flush
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-825-thread-1]: 
prune sis=segments_1:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-825-thread-1]: 
coreCloseExecutor-825-thread-1 finishFullFlush success=true
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
startCommit(): start
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]:  
 skip startCommit(): no changes pending
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-825-thread-1]: 
delete []
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
commit: pendingCommit == null; skip
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
commit: took 1.1 msec
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
commit: done
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
rollback
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
all running merges have aborted
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
rollback: done finish merges
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-825-thread-1]: 
abort
   [junit4]   2> 367069 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-825-thread-1]: 
done abort success=true
   [junit4]   2> 367070 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-825-thread-1]: 
rollback: infos=
   [junit4]   2> 367070 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-825-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 367070 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-825-thread-1]: 
delete []
   [junit4]   2> 367070 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-825-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 367070 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-825-thread-1]: 
delete []
   [junit4]   2> 367117 INFO  (coreCloseExecutor-825-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 367145 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 367169 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@158d675{/solr,null,UNAVAILABLE}
   [junit4]   2> 367375 INFO  
(SUITE-JvmMetricsTest-seed#[7EB35D04A4261AD0]-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_7EB35D04A4261AD0-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=1342, maxMBSortInHeap=5.630583874061317, 
sim=RandomSimilarity(queryNorm=true): {}, locale=ar-JO, timezone=Africa/Windhoek
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_112 
(32-bit)/cpus=3,threads=1,free=35031760,total=83419136
   [junit4]   2> NOTE: All tests run in this JVM: [UtilsToolTest, 
VersionInfoTest, SolrXmlInZkTest, ChaosMonkeyNothingIsSafeTest, 
DirectSolrSpellCheckerTest, TestExactSharedStatsCache, TestHashPartitioner, 
TestSurroundQueryParser, CachingDirectoryFactoryTest, 
TestDelegationWithHadoopAuth, TestIBSimilarityFactory, 
TestBM25SimilarityFactory, SegmentsInfoRequestHandlerTest, OverseerTest, 
SpatialFilterTest, TestDistributedSearch, SparseHLLTest, 
DistributedSuggestComponentTest, SolrMetricsIntegrationTest, 
TestClusterStateMutator, HLLSerializationTest, TestObjectReleaseTracker, 
TestManagedSchemaAPI, TestOnReconnectListenerSupport, 
TestSizeLimitedDistributedMap, XmlUpdateRequestHandlerTest, AnalyticsQueryTest, 
UUIDUpdateProcessorFallbackTest, TestElisionMultitermQuery, TestXmlQParser, 
DocValuesTest, TestRandomDVFaceting, TestFileDictionaryLookup, JvmMetricsTest]
   [junit4] Completed [91/670 (1!)] on J0 in 2.50s, 2 tests, 1 error <<< 
FAILURES!

[...truncated 1404 lines...]
   [junit4] Suite: org.apache.solr.cloud.TestSolrCloudWithDelegationTokens
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestSolrCloudWithDelegationTokens_7EB35D04A4261AD0-001\init-core-data-001
   [junit4]   2> 2293708 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[7EB35D04A4261AD0]-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> 2293713 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestSolrCloudWithDelegationTokens_7EB35D04A4261AD0-001\tempDir-001
   [junit4]   2> 2293713 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2293714 INFO  (Thread-4680) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2293714 INFO  (Thread-4680) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2293813 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:64814
   [junit4]   2> 2293823 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2293824 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1d45e76{/solr,null,AVAILABLE}
   [junit4]   2> 2293824 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@6923b1{HTTP/1.1,[http/1.1]}{127.0.0.1:64818}
   [junit4]   2> 2293825 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.e.j.s.Server Started @2299698ms
   [junit4]   2> 2293825 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=64818}
   [junit4]   2> 2293825 ERROR (jetty-launcher-2926-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2293825 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2293825 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2293825 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2293825 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-12-23T01:14:06.256Z
   [junit4]   2> 2293837 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 2293837 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3403ed{/solr,null,AVAILABLE}
   [junit4]   2> 2293838 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1a085c5{HTTP/1.1,[http/1.1]}{127.0.0.1:64823}
   [junit4]   2> 2293838 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.e.j.s.Server Started @2299711ms
   [junit4]   2> 2293838 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=64823}
   [junit4]   2> 2293838 ERROR (jetty-launcher-2926-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2293839 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 2293839 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2293839 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2293839 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-12-23T01:14:06.270Z
   [junit4]   2> 2293847 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2293848 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2293866 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64814/solr
   [junit4]   2> 2293874 INFO  (jetty-launcher-2926-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:64814/solr
   [junit4]   2> 2293877 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x159293dffc40004, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2293922 INFO  (jetty-launcher-2926-thread-1) 
[n:127.0.0.1:64818_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:64818_solr
   [junit4]   2> 2293923 INFO  (jetty-launcher-2926-thread-2) 
[n:127.0.0.1:64823_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:64823_solr
   [junit4]   2> 2293924 INFO  (jetty-launcher-2926-thread-1) 
[n:127.0.0.1:64818_solr    ] o.a.s.c.Overseer Overseer 
(id=97154213225955334-127.0.0.1:64818_solr-n_0000000000) starting
   [junit4]   2> 2293927 INFO  
(zkCallback-2936-thread-1-processing-n:127.0.0.1:64823_solr) 
[n:127.0.0.1:64823_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2293927 INFO  
(zkCallback-2937-thread-1-processing-n:127.0.0.1:64818_solr) 
[n:127.0.0.1:64818_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2293936 INFO  (jetty-launcher-2926-thread-1) 
[n:127.0.0.1:64818_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:64818_solr
   [junit4]   2> 2293983 INFO  (jetty-launcher-2926-thread-1) 
[n:127.0.0.1:64818_solr    ] o.a.s.c.CoreContainer Initializing authentication 
plugin: org.apache.solr.security.HttpParamDelegationTokenPlugin
   [junit4]   2> 2293984 INFO  
(zkCallback-2937-thread-1-processing-n:127.0.0.1:64818_solr) 
[n:127.0.0.1:64818_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2293985 INFO  
(zkCallback-2936-thread-1-processing-n:127.0.0.1:64823_solr) 
[n:127.0.0.1:64823_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2294035 INFO  (jetty-launcher-2926-thread-1) 
[n:127.0.0.1:64818_solr    ] o.a.s.s.KerberosPlugin Params: {token.valid=30, 
delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, cookie.path=/, 
zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, 
token.validity=36000, signer.secret.provider.zookeeper.path=/token, 
type=kerberos, zk-dt-secret-manager.enable=true, kerberos.name.rules=DEFAULT, 
signer.secret.provider=zookeeper}
   [junit4]   2> 2294065 INFO  (jetty-launcher-2926-thread-2) 
[n:127.0.0.1:64823_solr    ] o.a.s.c.CoreContainer Initializing authentication 
plugin: org.apache.solr.security.HttpParamDelegationTokenPlugin
   [junit4]   2> 2294065 INFO  (jetty-launcher-2926-thread-2) 
[n:127.0.0.1:64823_solr    ] o.a.s.s.KerberosPlugin Params: {token.valid=30, 
delegation-token.token-kind=solr-dt, cookie.domain=127.0.0.1, cookie.path=/, 
zk-dt-secret-manager.znodeWorkingPath=solr/security/zkdtsm, 
token.validity=36000, signer.secret.provider.zookeeper.path=/token, 
type=kerberos, zk-dt-secret-manager.enable=true, kerberos.name.rules=DEFAULT, 
signer.secret.provider=zookeeper}
   [junit4]   2> 2294402 INFO  (jetty-launcher-2926-thread-1) 
[n:127.0.0.1:64818_solr    ] o.a.c.f.i.CuratorFrameworkImpl Starting
   [junit4]   2> 2294402 INFO  (jetty-launcher-2926-thread-2) 
[n:127.0.0.1:64823_solr    ] o.a.c.f.i.CuratorFrameworkImpl Starting
   [junit4]   2> 2294469 INFO  (jetty-launcher-2926-thread-1-EventThread) 
[n:127.0.0.1:64818_solr    ] o.a.c.f.s.ConnectionStateManager State change: 
CONNECTED
   [junit4]   2> 2294470 INFO  (jetty-launcher-2926-thread-2-EventThread) 
[n:127.0.0.1:64823_solr    ] o.a.c.f.s.ConnectionStateManager State change: 
CONNECTED
   [junit4]   2> 2294673 ERROR (jetty-launcher-2926-thread-1) 
[n:127.0.0.1:64818_solr    ] o.a.h.u.Shell Failed to locate the winutils binary 
in the hadoop binary path
   [junit4]   2> java.io.IOException: Could not locate executable 
null\bin\winutils.exe in the Hadoop binaries.
   [junit4]   2>        at 
org.apache.hadoop.util.Shell.getQualifiedBinPath(Shell.java:356)
   [junit4]   2>        at 
org.apache.hadoop.util.Shell.getWinUtilsPath(Shell.java:371)
   [junit4]   2>        at org.apache.hadoop.util.Shell.<clinit>(Shell.java:364)
   [junit4]   2>        at 
org.apache.hadoop.util.StringUtils.<clinit>(StringUtils.java:80)
   [junit4]   2>        at 
org.apache.hadoop.conf.Configuration.getBoolean(Configuration.java:1437)
   [junit4]   2>        at 
org.apache.hadoop.security.token.delegation.web.DelegationTokenManager.<init>(DelegationTokenManager.java:115)
   [junit4]   2>        at 
org.apache.hadoop.security.token.delegation.web.DelegationTokenAuthenticationHandler.initTokenManager(DelegationTokenAuthenticationHandler.java:148)
   [junit4]   2>        at 
org.apache.hadoop.security.token.delegation.web.DelegationTokenAuthenticationHandler.init(DelegationTokenAuthenticationHandler.java:118)
   [junit4]   2>        at 
org.apache.solr.security.HttpParamDelegationTokenPlugin$HttpParamDelegationTokenAuthenticationHandler.init(HttpParamDelegationTokenPlugin.java:178)
   [junit4]   2>        at 
org.apache.hadoop.security.authentication.server.AuthenticationFilter.initializeAuthHandler(AuthenticationFilter.java:238)
   [junit4]   2>        at 
org.apache.hadoop.security.token.delegation.web.DelegationTokenAuthenticationFilter.initializeAuthHandler(DelegationTokenAuthenticationFilter.java:209)
   [junit4]   2>        at 
org.apache.solr.security.DelegationTokenKerberosFilter.initializeAuthHandler(DelegationTokenKerberosFilter.java:142)
   [junit4]   2>        at 
org.apache.hadoop.security.authentication.server.AuthenticationFilter.init(AuthenticationFilter.java:227)
   [junit4]   2>        at 
org.apache.hadoop.security.token.delegation.web.DelegationTokenAuthenticationFilter.init(DelegationTokenAuthenticationFilter.java:175)
   [junit4]   2>        at 
org.apache.solr.security.DelegationTokenKerberosFilter.init(DelegationTokenKerberosFilter.java:71)
   [junit4]   2>        at 
org.apache.solr.security.HttpParamDelegationTokenPlugin.init(HttpParamDelegationTokenPlugin.java:134)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.initializeAuthenticationPlugin(CoreContainer.java:329)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reloadSecurityProperties(CoreContainer.java:607)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.load(CoreContainer.java:482)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.createCoreContainer(SolrDispatchFilter.java:235)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:167)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.FilterHolder.initialize(FilterHolder.java:137)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:873)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.updateMappings(ServletHandler.java:1565)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.setFilterMappings(ServletHandler.java:1599)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterMapping(ServletHandler.java:1285)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterWithMapping(ServletHandler.java:1130)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletContextHandler.addFilter(ServletContextHandler.java:448)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:260)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.setStarted(AbstractLifeCycle.java:179)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:69)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:348)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:321)
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.startJettySolrRunner(MiniSolrCloudCluster.java:376)
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.lambda$new$0(MiniSolrCloudCluster.java:239)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2294907 INFO  (jetty-launcher-2926-thread-2) 
[n:127.0.0.1:64823_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestSolrCloudWithDelegationTokens_7EB35D04A4261AD0-001\tempDir-001\node2\.
   [junit4]   2> 2294908 INFO  (jetty-launcher-2926-thread-1) 
[n:127.0.0.1:64818_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestSolrCloudWithDelegationTokens_7EB35D04A4261AD0-001\tempDir-001\node1\.
   [junit4]   2> 2295905 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x159293dffc40009, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2295933 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenCancel
   [junit4]   2> 2297161 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297163 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297164 ERROR (qtp25387681-18939) [    ] 
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path 
[/ZKDTSMTokensRoot/DT_1]
   [junit4]   2> 2297194 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x159293dffc4000a, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2297208 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297209 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297222 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297223 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x159293dffc4000b, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2297228 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297349 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297413 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297431 ERROR (qtp25387681-18945) [    ] 
o.a.h.s.t.d.ZKDelegationTokenSecretManager No node in path 
[/ZKDTSMTokensRoot/DT_2]
   [junit4]   2> 2297437 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x159293dffc4000c, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2297509 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297522 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297526 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297533 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x159293dffc4000d, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2297538 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297540 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenCancel-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenCancel
   [junit4]   2> 2297622 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenSolrClient
   [junit4]   2> 2297629 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297645 INFO  (qtp25387681-18962) [n:127.0.0.1:64818_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg8GigFZTUqTBgMDFHEk5ktpIK8v2AreD5yxGI1ruYAJB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297645 INFO  (qtp25387681-18962) [n:127.0.0.1:64818_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg8GigFZTUqTBgMDFHEk5ktpIK8v2AreD5yxGI1ruYAJB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297646 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenSolrClient-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenSolrClient
   [junit4]   2> 2297669 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenRenew
   [junit4]   2> 2297700 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297703 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297704 INFO  (qtp25387681-18940) [n:127.0.0.1:64818_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg82igFZTUqTNgQDFKwmLky70FXQl0OgnWK0atryoMlyB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297704 INFO  (qtp25387681-18940) [n:127.0.0.1:64818_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg82igFZTUqTNgQDFKwmLky70FXQl0OgnWK0atryoMlyB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297705 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x159293dffc4000e, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2297708 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297710 INFO  (qtp4954729-18963) [n:127.0.0.1:64823_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg82igFZTUqTNgQDFKwmLky70FXQl0OgnWK0atryoMlyB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297711 INFO  (qtp4954729-18963) [n:127.0.0.1:64823_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg82igFZTUqTNgQDFKwmLky70FXQl0OgnWK0atryoMlyB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297713 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297728 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297729 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297730 INFO  (qtp25387681-18945) [n:127.0.0.1:64818_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg9higFZTUqTYQUDFPrbY4jzKD1-8oL2FepFL4aQNFAOB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297730 INFO  (qtp25387681-18945) [n:127.0.0.1:64818_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg9higFZTUqTYQUDFPrbY4jzKD1-8oL2FepFL4aQNFAOB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297735 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297740 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297741 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297742 INFO  (qtp25387681-18960) [n:127.0.0.1:64818_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg9higFZTUqTYQUDFPrbY4jzKD1-8oL2FepFL4aQNFAOB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297743 INFO  (qtp25387681-18960) [n:127.0.0.1:64818_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg9higFZTUqTYQUDFPrbY4jzKD1-8oL2FepFL4aQNFAOB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297746 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297759 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297760 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297763 INFO  (qtp25387681-18940) [n:127.0.0.1:64818_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg-BigFZTUqTgQYDFH3iZN4i05iASKdUYTBHyVn4vYqlB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297763 INFO  (qtp25387681-18940) [n:127.0.0.1:64818_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg-BigFZTUqTgQYDFH3iZN4i05iASKdUYTBHyVn4vYqlB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297763 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x159293dffc40011, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2297768 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297769 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297771 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297775 INFO  (qtp4954729-18956) [n:127.0.0.1:64823_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg-BigFZTUqTgQYDFH3iZN4i05iASKdUYTBHyVn4vYqlB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297775 INFO  (qtp4954729-18956) [n:127.0.0.1:64823_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg-BigFZTUqTgQYDFH3iZN4i05iASKdUYTBHyVn4vYqlB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297777 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297788 INFO  (qtp25387681-18938) [n:127.0.0.1:64818_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg-iigFZTUqTogcDFI6yLZgtBb_QuX6UzG5Y8u80c0EVB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297788 INFO  (qtp25387681-18938) [n:127.0.0.1:64818_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg-iigFZTUqTogcDFI6yLZgtBb_QuX6UzG5Y8u80c0EVB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297793 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 2297794 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:64814/solr ready
   [junit4]   2> 2297796 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297797 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x159293dffc40013, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 2297800 INFO  (qtp4954729-18949) [n:127.0.0.1:64823_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg-iigFZTUqTogcDFI6yLZgtBb_QuX6UzG5Y8u80c0EVB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297800 INFO  (qtp4954729-18949) [n:127.0.0.1:64823_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg-iigFZTUqTogcDFI6yLZgtBb_QuX6UzG5Y8u80c0EVB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297802 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297803 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenRenew-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testDelegationTokenRenew
   [junit4]   2> 2297827 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testDelegationTokenVerify
   [junit4]   2> 2297837 INFO  (qtp25387681-18962) [n:127.0.0.1:64818_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params 
action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg_TigFZTUqT0wgDFJr_7XtkxHxBawA9Hm1zQuKVi7oVB3NvbHItZHQA&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297837 INFO  (qtp25387681-18962) [n:127.0.0.1:64818_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={action=LIST&delegation=GgADYmFyA2JhcgCKAVkpPg_TigFZTUqT0wgDFJr_7XtkxHxBawA9Hm1zQuKVi7oVB3NvbHItZHQA&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2297840 WARN  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[7EB35D04A4261AD0])
 [    ] o.a.h.c.p.ResponseProcessCookies Invalid cookie header: "Set-Cookie: 
hadoop.auth=; Path=/; Domain=127.0.0.1; Expires=C, 01-janv.-1970 00:00:00 GMT; 
HttpOnly". Invalid 'expires' attribute: C, 01-janv.-1970 00:00:00 GMT
   [junit4]   2> 2297849 INFO  
(TEST-TestSolrCloudWithDelegationTokens.testDelegationTokenVerify-seed#[7EB35D04A4261AD0])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 22978

[...truncated too long message...]

ession expired for /live_nodes]
   [junit4]   2> 2299525 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 2299525 ERROR 
(Thread[Thread-4705,5,TGRP-TestSolrCloudWithDelegationTokens]) 
[n:127.0.0.1:64818_solr    ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager 
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
   [junit4]   2> 2299527 INFO  (jetty-launcher-2926-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1d45e76{/solr,null,UNAVAILABLE}
   [junit4]   2> 2299529 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:64814 64814
   [junit4]   2> 2299530 INFO  (Thread-4680) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:64814 64814
   [junit4]   2> 2299531 WARN  (Thread-4680) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /solr/aliases.json
   [junit4]   2>        15      /solr/clusterprops.json
   [junit4]   2>        2       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /solr/clusterstate.json
   [junit4]   2>        4       /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMKeyIdRoot
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_7
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_6
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_9
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_8
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_1
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_1
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_3
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_3
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_2
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_5
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_4
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_4
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_12
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMSeqNumRoot
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_11
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_10
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        15      /solr/live_nodes
   [junit4]   2>        15      /solr/collections
   [junit4]   2>        3       /solr/overseer/queue
   [junit4]   2>        3       /solr/overseer/collection-queue-work
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot
   [junit4]   2>        2       /solr/overseer/queue-work
   [junit4]   2>        2       
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot
   [junit4]   2> 
   [junit4]   2> 2299531 INFO  
(SUITE-TestSolrCloudWithDelegationTokens-seed#[7EB35D04A4261AD0]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.TestSolrCloudWithDelegationTokens_7EB35D04A4261AD0-001
   [junit4]   2> Dec 23, 2016 1:14:11 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 2 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: 
codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=9, maxDocsPerChunk=6, blockSize=774), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION,
 chunkSize=9, blockSize=774)), sim=RandomSimilarity(queryNorm=true): {}, 
locale=lv, timezone=SystemV/PST8
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_112 
(32-bit)/cpus=3,threads=1,free=73435352,total=305373184
   [junit4]   2> NOTE: All tests run in this JVM: [HLLUtilTest, 
TestPKIAuthenticationPlugin, TestBlendedInfixSuggestions, 
TestLMJelinekMercerSimilarityFactory, DistanceFunctionTest, 
TestCollapseQParserPlugin, FileBasedSpellCheckerTest, 
TestSubQueryTransformerDistrib, LeaderElectionContextKeyTest, 
TestReversedWildcardFilterFactory, TestSolrCloudWithSecureImpersonation, 
ChaosMonkeySafeLeaderTest, TestReRankQParserPlugin, TestCloudInspectUtil, 
TestUseDocValuesAsStored, TestValueSourceCache, QueryResultKeyTest, 
AnalyticsMergeStrategyTest, BigEndianAscendingWordDeserializerTest, 
TestRTimerTree, SuggestComponentContextFilterQueryTest, 
DistribJoinFromCollectionTest, TestStressRecovery, BitVectorTest, TestTrie, 
TestRandomFlRTGCloud, DirectUpdateHandlerOptimizeTest, 
TestLocalFSCloudBackupRestore, TestGeoJSONResponseWriter, 
SolrCmdDistributorTest, TestMissingGroups, TestExactStatsCache, 
TestXmlQParserPlugin, OpenCloseCoreStressTest, 
TestDynamicFieldCollectionResource, TestStandardQParsers, UpdateParamsTest, 
MinimalSchemaTest, SharedFSAutoReplicaFailoverTest, CacheHeaderTest, 
ReplicationFactorTest, ConjunctionSolrSpellCheckerTest, 
DeleteInactiveReplicaTest, SuggesterTSTTest, PreAnalyzedFieldTest, BasicZkTest, 
TestHdfsUpdateLog, RemoteQueryErrorTest, CursorMarkTest, TestCustomSort, 
TestJmxMonitoredMap, OverseerModifyCollectionTest, 
FullSolrCloudDistribCmdsTest, TestWriterPerf, HdfsBasicDistributedZk2Test, 
BasicDistributedZk2Test, RAMDirectoryFactoryTest, TestBadConfig, 
JsonLoaderTest, TestTrieFacet, LeaderElectionIntegrationTest, TestFastWriter, 
TestSolr4Spatial, TestLeaderElectionZkExpiry, TestSolr4Spatial2, 
TestConfigOverlay, TestIntervalFaceting, TestMiniSolrCloudCluster, 
ClusterStateTest, DocExpirationUpdateProcessorFactoryTest, 
TestFieldCacheSanityChecker, TestDFRSimilarityFactory, CollectionReloadTest, 
TestFreeTextSuggestions, HdfsUnloadDistributedZkTest, MetricUtilsTest, 
JavabinLoaderTest, TestShortCircuitedRequests, BadIndexSchemaTest, 
TestAnalyzedSuggestions, UUIDFieldTest, DeleteNodeTest, 
TestManagedSchemaThreadSafety, TestRandomFaceting, 
TestSimpleTrackingShardHandler, ResponseLogComponentTest, 
TestEmbeddedSolrServerConstructors, DocValuesMissingTest, TestNRTOpen, 
CdcrBootstrapTest, LeaderInitiatedRecoveryOnShardRestartTest, 
ShardRoutingCustomTest, SaslZkACLProviderTest, TestDocBasedVersionConstraints, 
TestFieldCacheSortRandom, PKIAuthenticationIntegrationTest, 
TestClusterProperties, ParsingFieldUpdateProcessorsTest, TestScoreJoinQPScore, 
QueryParsingTest, CollectionTooManyReplicasTest, TestJavabinTupleStreamParser, 
TestCodecSupport, HdfsRecoverLeaseTest, RulesTest, TestSolrQueryParser, 
BasicFunctionalityTest, TestFieldTypeCollectionResource, CircularListTest, 
ClassificationUpdateProcessorTest, TestReload, SliceStateTest, 
BasicAuthIntegrationTest, CreateCollectionCleanupTest, TestShardHandlerFactory, 
DistributedFacetPivotWhiteBoxTest, TestLMDirichletSimilarityFactory, 
TestConfig, GraphQueryTest, EchoParamsTest, 
HdfsCollectionsAPIDistributedZkTest, SuggesterWFSTTest, AliasIntegrationTest, 
StressHdfsTest, BlockCacheTest, TestDistributedGrouping, 
TestSubQueryTransformer, BadCopyFieldTest, DateMathParserTest, 
TestLuceneMatchVersion, TestSha256AuthenticationProvider, 
TestSchemaSimilarityResource, CollectionsAPIDistributedZkTest, 
TestRandomCollapseQParserPlugin, TestTestInjection, TestQueryUtils, 
TestSolrCloudSnapshots, TestSolrQueryResponse, TestAuthenticationFramework, 
TestFieldCache, DebugComponentTest, HttpSolrCallGetCoreTest, 
TestMiniSolrCloudClusterSSL, LoggingHandlerTest, StatsComponentTest, 
TestConfigSetsAPIZkFailure, TestInfoStreamLogging, TestJsonFacets, 
TestManagedResourceStorage, TestRawResponseWriter, TestAtomicUpdateErrorCases, 
CdcrVersionReplicationTest, FieldAnalysisRequestHandlerTest, TestJoin, 
CloudMLTQParserTest, WordBreakSolrSpellCheckerTest, ForceLeaderTest, 
TestFuzzyAnalyzedSuggestions, DistributedQueryComponentOptimizationTest, 
SuggesterTest, TestRecovery, TestZkChroot, SyncSliceTest, 
DistributedTermsComponentTest, SimpleFacetsTest, SolrCoreTest, 
TestGroupingSearch, QueryElevationComponentTest, TestFiltering, 
DirectUpdateHandlerTest, TestIndexSearcher, HighlighterTest, 
CurrencyFieldOpenExchangeTest, DistributedQueryElevationComponentTest, 
TestExtendedDismaxParser, CoreAdminHandlerTest, SolrCoreCheckLockOnStartupTest, 
FieldMutatingUpdateProcessorTest, SortByFunctionTest, DocValuesMultiTest, 
SolrInfoMBeanTest, LukeRequestHandlerTest, TermsComponentTest, 
TermVectorComponentTest, FastVectorHighlighterTest, SolrPluginUtilsTest, 
TestJmxIntegration, ReturnFieldsTest, UniqFieldsUpdateProcessorFactoryTest, 
TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter, 
CSVRequestHandlerTest, TestComponentsName, TestLFUCache, 
TestSweetSpotSimilarityFactory, TestFastOutputStream, 
OpenExchangeRatesOrgProviderTest, TestFastLRUCache, 
TestSuggestSpellingConverter, SpellingQueryConverterTest, TestUtils, 
FileUtilsTest, DistributedMLTComponentTest, DistributedIntervalFacetingTest, 
TestJettySolrRunner, ConnectionReuseTest, AssignTest, 
AsyncCallRequestStatusResponseTest, CloudExitableDirectoryReaderTest, 
CollectionStateFormat2Test, CollectionsAPISolrJTest, 
DeleteLastCustomShardedReplicaTest, DeleteShardTest, DistributedQueueTest, 
DistributedVersionInfoTest, LeaderFailoverAfterPartitionTest, 
LeaderFailureAfterFreshStartTest, MultiThreadedOCPTest, ReplaceNodeTest, 
RestartWhileUpdatingTest, RollingRestartTest, ShardSplitTest, 
TestConfigSetsAPIExclusivity, TestDownShardTolerantSearch, 
TestHdfsCloudBackupRestore, TestLeaderElectionWithEmptyReplica, 
TestRandomRequestDistribution, TestRequestForwarding, 
TestRequestStatusCollectionAPI, TestSolrCloudWithDelegationTokens]
   [junit4] Completed [517/670 (2!)] on J1 in 6.10s, 8 tests, 1 failure <<< 
FAILURES!

[...truncated 55049 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to