Build: https://builds.apache.org/job/Lucene-Solr-Tests-5.5-Java8/26/

4 tests failed.
FAILED:  
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh

Error Message:
Could not find collection : c1

Stack Trace:
org.apache.solr.common.SolrException: Could not find collection : c1
        at 
__randomizedtesting.SeedInfo.seed([7F5E2DD882F4730:184F932A584F81F5]:0)
        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136)
        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42)
        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:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        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:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        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:  junit.framework.TestSuite.org.apache.solr.core.TestLazyCores

Error Message:
ObjectTracker found 4 object(s) that were not released!!! [SolrCore, 
MockDirectoryWrapper, MockDirectoryWrapper, MDCAwareThreadPoolExecutor]

Stack Trace:
java.lang.AssertionError: ObjectTracker found 4 object(s) that were not 
released!!! [SolrCore, MockDirectoryWrapper, MockDirectoryWrapper, 
MDCAwareThreadPoolExecutor]
        at __randomizedtesting.SeedInfo.seed([7F5E2DD882F4730]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:228)
        at sun.reflect.GeneratedMethodAccessor31.invoke(Unknown Source)
        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:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
        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:  junit.framework.TestSuite.org.apache.solr.core.TestLazyCores

Error Message:
1 thread leaked from SUITE scope at org.apache.solr.core.TestLazyCores:     1) 
Thread[id=10853, name=searcherExecutor-4886-thread-1, state=WAITING, 
group=TGRP-TestLazyCores]         at sun.misc.Unsafe.park(Native Method)        
 at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         
at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 
        at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.core.TestLazyCores: 
   1) Thread[id=10853, name=searcherExecutor-4886-thread-1, state=WAITING, 
group=TGRP-TestLazyCores]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
        at __randomizedtesting.SeedInfo.seed([7F5E2DD882F4730]:0)


FAILED:  junit.framework.TestSuite.org.apache.solr.core.TestLazyCores

Error Message:
There are still zombie threads that couldn't be terminated:    1) 
Thread[id=10853, name=searcherExecutor-4886-thread-1, state=WAITING, 
group=TGRP-TestLazyCores]         at sun.misc.Unsafe.park(Native Method)        
 at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)         
at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)     
    at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)   
      at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127) 
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) 
        at java.lang.Thread.run(Thread.java:745)

Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   1) Thread[id=10853, name=searcherExecutor-4886-thread-1, state=WAITING, 
group=TGRP-TestLazyCores]
        at sun.misc.Unsafe.park(Native Method)
        at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
        at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
        at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
        at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
        at java.lang.Thread.run(Thread.java:745)
        at __randomizedtesting.SeedInfo.seed([7F5E2DD882F4730]:0)




Build Log:
[...truncated 11307 lines...]
   [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_7F5E2DD882F4730-001/init-core-data-001
   [junit4]   2> 832907 INFO  
(SUITE-ZkStateReaderTest-seed#[7F5E2DD882F4730]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 832909 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation
   [junit4]   2> 832911 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 832911 INFO  (Thread-1465) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 832911 INFO  (Thread-1465) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 833011 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.ZkTestServer start zk server on port:38513
   [junit4]   2> 833011 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 833018 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 833020 INFO  (zkCallback-16997-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@437fc4 name:ZooKeeperConnection 
Watcher:127.0.0.1:38513 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 833020 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 833020 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 833021 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 833021 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 833022 INFO  (zkCallback-16998-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5e12cc3b 
name:ZooKeeperConnection Watcher:127.0.0.1:38513 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 833022 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 833022 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 833022 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 833023 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 833023 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 833043 INFO  (zkCallback-16999-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@155d70e name:ZooKeeperConnection 
Watcher:127.0.0.1:38513/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 833043 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 833044 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 833044 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 833045 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 833045 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 833046 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 833046 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 833047 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 833049 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 833049 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 833049 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 833050 INFO  (zkCallback-16999-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 833051 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 833051 INFO  (zkCallback-16999-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 833051 INFO  (zkCallback-16999-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 833106 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38513 38513
   [junit4]   2> 833299 INFO  (Thread-1465) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:38513 38513
   [junit4]   2> 833300 INFO  
(TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[7F5E2DD882F4730]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation
   [junit4]   2> 833307 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay
   [junit4]   2> 833311 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 833312 INFO  (Thread-1466) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 833312 INFO  (Thread-1466) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 833412 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer start zk server on port:34937
   [junit4]   2> 833412 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 833412 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 833414 INFO  (zkCallback-17000-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@3b0c947e 
name:ZooKeeperConnection Watcher:127.0.0.1:34937 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 833414 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 833415 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 833415 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 833415 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 833416 INFO  (zkCallback-17001-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@66c02633 
name:ZooKeeperConnection Watcher:127.0.0.1:34937 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 833416 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 833416 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 833416 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 833417 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 833418 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 833418 INFO  (zkCallback-17002-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@7ed05650 
name:ZooKeeperConnection Watcher:127.0.0.1:34937/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 833418 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 833418 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 833418 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 833419 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 833419 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 833420 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 833421 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 833422 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 833423 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 833423 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 833423 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 833424 INFO  (zkCallback-17002-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 833424 INFO  (zkCallback-17002-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 833476 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 833481 INFO  (zkCallback-17002-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 833481 INFO  (zkCallback-17002-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 833481 INFO  (zkCallback-17002-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 833542 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34937 34937
   [junit4]   2> 833738 INFO  (Thread-1466) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34937 34937
   [junit4]   2> 833739 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay
   [junit4]   2> 833740 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 833740 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 833741 INFO  (Thread-1467) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 833741 INFO  (Thread-1467) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 833841 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer start zk server on port:59000
   [junit4]   2> 833841 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 833842 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 833845 INFO  (zkCallback-17003-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@17e966f9 
name:ZooKeeperConnection Watcher:127.0.0.1:59000 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 833845 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 833846 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 833846 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 833848 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 833848 INFO  (zkCallback-17004-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@42b3bf68 
name:ZooKeeperConnection Watcher:127.0.0.1:59000 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 833849 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 833849 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 833849 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 833850 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 833853 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 833853 INFO  (zkCallback-17005-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@6cc4b65d 
name:ZooKeeperConnection Watcher:127.0.0.1:59000/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 833853 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 833854 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 833854 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 833854 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 833855 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 833856 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 833856 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 833856 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 833857 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 833858 INFO  (zkCallback-17005-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 833861 INFO  (zkCallback-17005-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 833909 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 833909 INFO  (zkCallback-17005-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 833911 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:59000 59000
   [junit4]   2> 834195 INFO  (Thread-1467) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:59000 59000
   [junit4]   2> 834196 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy
   [junit4]   2> 834205 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 834205 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 834216 INFO  (Thread-1468) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 834216 INFO  (Thread-1468) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 834316 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer start zk server on port:57810
   [junit4]   2> 834316 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 834317 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 834320 INFO  (zkCallback-17006-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@76abf4ae 
name:ZooKeeperConnection Watcher:127.0.0.1:57810 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 834321 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 834321 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 834321 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 834341 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 834349 INFO  (zkCallback-17007-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@66d1c33b 
name:ZooKeeperConnection Watcher:127.0.0.1:57810 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 834349 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 834350 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 834350 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 834352 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 834353 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 834360 INFO  (zkCallback-17008-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@a4b8dbd name:ZooKeeperConnection 
Watcher:127.0.0.1:57810/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 834360 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 834360 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 834360 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 834361 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 834362 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 834362 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 834363 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 834363 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 834364 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 834365 INFO  (zkCallback-17008-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 834366 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 834370 INFO  (zkCallback-17008-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 834370 WARN  (zkCallback-17008-thread-2) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /clusterstate.json]
   [junit4]   2> 834373 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:57810 57810
   [junit4]   2> 834568 INFO  (Thread-1468) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:57810 57810
   [junit4]   2> 834569 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testStateFormatUpdateWithExplicitRefreshLazy
   [junit4]   2> 834571 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> 834571 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 834571 INFO  (Thread-1469) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 834571 INFO  (Thread-1469) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 834671 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer start zk server on port:39728
   [junit4]   2> 834672 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 834672 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 834674 INFO  (zkCallback-17009-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@30fb2c02 
name:ZooKeeperConnection Watcher:127.0.0.1:39728 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 834674 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 834674 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 834675 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 834675 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 834676 INFO  (zkCallback-17010-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@72472193 
name:ZooKeeperConnection Watcher:127.0.0.1:39728 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 834676 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 834676 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 834676 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 834683 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 834683 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 834683 INFO  (zkCallback-17011-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@31cfcacf 
name:ZooKeeperConnection Watcher:127.0.0.1:39728/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 834683 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 834684 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 834684 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 834685 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 834685 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 834686 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 834689 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 834689 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 834691 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 834691 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader Deleting data for [c1]
   [junit4]   2> 834691 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 834692 INFO  (zkCallback-17011-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 834695 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 834697 INFO  (zkCallback-17011-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for 
collection [c1] has occurred - updating... (live nodes size: [0])
   [junit4]   2> 834697 WARN  (zkCallback-17011-thread-1) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /collections/c1/state.json]
   [junit4]   2> 834701 INFO  (zkCallback-17011-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred 
- updating... (live nodes size: [0])
   [junit4]   2> 834701 WARN  (zkCallback-17011-thread-2) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /clusterstate.json]
   [junit4]   2> 834702 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:39728 39728
   [junit4]   2> 835130 INFO  (Thread-1469) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:39728 39728
   [junit4]   2> 835131 INFO  
(TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkStateReaderTest 
-Dtests.method=testStateFormatUpdateWithExplicitRefresh 
-Dtests.seed=7F5E2DD882F4730 -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=it-IT -Dtests.timezone=America/Manaus -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.56s J2 | 
ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh <<<
   [junit4]    > Throwable #1: org.apache.solr.common.SolrException: Could not 
find collection : c1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([7F5E2DD882F4730:184F932A584F81F5]:0)
   [junit4]    >        at 
org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:170)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:136)
   [junit4]    >        at 
org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh(ZkStateReaderTest.java:42)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 835134 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched
   [junit4]   2> 835134 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 835135 INFO  (Thread-1470) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 835135 INFO  (Thread-1470) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 835234 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer start zk server on port:56387
   [junit4]   2> 835234 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 835235 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 835238 INFO  (zkCallback-17012-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@5c48422f 
name:ZooKeeperConnection Watcher:127.0.0.1:56387 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 835238 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 835238 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 835239 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 835239 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 835239 INFO  (zkCallback-17013-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2ab72ccc 
name:ZooKeeperConnection Watcher:127.0.0.1:56387 got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 835239 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 835240 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 835240 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /solr
   [junit4]   2> 835241 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 835241 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 835242 INFO  (zkCallback-17014-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@2f69724d 
name:ZooKeeperConnection Watcher:127.0.0.1:56387/solr got event WatchedEvent 
state:SyncConnected type:None path:null path:null type:None
   [junit4]   2> 835242 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 835242 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 835245 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 835246 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 835246 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 835247 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 835248 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 835248 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 835249 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.SolrZkClient makePath: /collections/c1
   [junit4]   2> 835250 INFO  (zkCallback-17014-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 835250 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/c1/state.json
   [junit4]   2> 835251 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader addZkWatch [c1]
   [junit4]   2> 835251 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0]
   [junit4]   2> 835251 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.c.ZkStateReader Removing watch for uninteresting collection [c1]
   [junit4]   2> 835252 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56387 56387
   [junit4]   2> 835366 INFO  (Thread-1470) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:56387 56387
   [junit4]   2> 835367 INFO  
(TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[7F5E2DD882F4730])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched
   [junit4]   2> 835367 INFO  
(SUITE-ZkStateReaderTest-seed#[7F5E2DD882F4730]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J2/temp/solr.cloud.overseer.ZkStateReaderTest_7F5E2DD882F4730-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene54): {}, 
docValues:{}, sim=DefaultSimilarity, locale=it-IT, timezone=America/Manaus
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=1,free=119140744,total=467140608
   [junit4]   2> NOTE: All tests run in this JVM: [TestCloudInspectUtil, 
TestWriterPerf, UnloadDistributedZkTest, DirectUpdateHandlerTest, 
TestSolrConfigHandlerConcurrent, TestStressLiveNodes, SuggesterWFSTTest, 
FieldMutatingUpdateProcessorTest, TestZkChroot, TestFieldCollectionResource, 
TestBlobHandler, FullSolrCloudDistribCmdsTest, LeaderElectionTest, 
TestCollapseQParserPlugin, TestXIncludeConfig, TestPHPSerializedResponseWriter, 
DocValuesMultiTest, TestFastWriter, OverseerTest, 
TestDistributedStatsComponentCardinality, BadComponentTest, 
DistributedQueryComponentOptimizationTest, CoreMergeIndexesAdminHandlerTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestCloudSchemaless, 
ScriptEngineTest, TestMaxScoreQueryParser, TestElisionMultitermQuery, 
TestAnalyzeInfixSuggestions, HardAutoCommitTest, TestSolrIndexConfig, 
PrimitiveFieldTypeTest, TestSchemaResource, QueryParsingTest, 
BlockDirectoryTest, BinaryUpdateRequestHandlerTest, TestConfigOverlay, 
CircularListTest, ConfigSetsAPITest, BJQParserTest, 
DistributedFacetPivotLargeTest, StatsComponentTest, UpdateParamsTest, 
HttpPartitionTest, TestNamedUpdateProcessors, BasicDistributedZk2Test, 
RegexBoostProcessorTest, CursorMarkTest, SampleTest, AtomicUpdatesTest, 
TestReloadAndDeleteDocs, TestFieldSortValues, ZkStateReaderTest]
   [junit4] Completed [222/572 (1!)] on J2 in 2.47s, 6 tests, 1 error <<< 
FAILURES!

[...truncated 575 lines...]
   [junit4] Suite: org.apache.solr.core.TestLazyCores
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/init-core-data-001
   [junit4]   2> 1066263 INFO  
(SUITE-TestLazyCores-seed#[7F5E2DD882F4730]-worker) [    ] o.a.s.SolrTestCaseJ4 
Randomized ssl (false) and clientAuth (false)
   [junit4]   2> 1066267 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testCachingLimit
   [junit4]   2> 1066275 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001'
   [junit4]   2> 1066275 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1066275 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1066276 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreContainer New CoreContainer 1311295881
   [junit4]   2> 1066276 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001]
   [junit4]   2> 1066276 WARN  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/lib
 to classpath: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/lib
   [junit4]   2> 1066276 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 
600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
   [junit4]   2> 1066277 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 1066277 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.SolrCores Allocating transient cache for 4 transient cores
   [junit4]   2> 1066279 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1066279 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1066279 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for 
authorization module.
   [junit4]   2> 1066279 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreContainer No authentication plugin used.
   [junit4]   2> 1066280 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, 
config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=false, dataDir=data/}
   [junit4]   2> 1066280 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection2, 
config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=true, dataDir=data/}
   [junit4]   2> 1066280 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection3, 
config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=on, dataDir=data/}
   [junit4]   2> 1066280 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection4, 
config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=false, dataDir=data/}
   [junit4]   2> 1066280 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection5, 
config=solrconfig.xml, loadOnStartup=true, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=false, dataDir=data/}
   [junit4]   2> 1066280 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection6, 
config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=true, dataDir=data/}
   [junit4]   2> 1066280 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection7, 
config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=true, dataDir=data/}
   [junit4]   2> 1066280 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection8, 
config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=true, dataDir=data/}
   [junit4]   2> 1066281 INFO  
(TEST-TestLazyCores.testCachingLimit-seed#[7F5E2DD882F4730]) [    ] 
o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection9, 
config=solrconfig.xml, loadOnStartup=false, schema=schema.xml, 
configSetProperties=configsetprops.json, transient=true, dataDir=data/}
   [junit4]   2> 1066296 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1'
   [junit4]   2> 1066297 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1066297 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1066301 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1066303 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.1
   [junit4]   2> 1066342 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2'
   [junit4]   2> 1066342 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1066342 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1066345 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1066346 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1066348 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=tiny
   [junit4]   2> 1066350 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5'
   [junit4]   2> 1066350 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1066350 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1066351 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1066352 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1'
   [junit4]   2> 1066352 INFO  (coreLoadExecutor-4883-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1
   [junit4]   2> 1066352 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1066352 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/data/]
   [junit4]   2> 1066352 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection1
   [junit4]   2> 1066353 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/data
   [junit4]   2> 1066353 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/data/index/
   [junit4]   2> 1066353 WARN  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1066353 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/data/index
   [junit4]   2> 1066353 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=39, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2386206661874497]
   [junit4]   2> 1066353 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.c.SolrConfig current version of requestparams : -1
   [junit4]   2> 1066353 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.1
   [junit4]   2> 1066355 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.5.1
   [junit4]   2> 1066357 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1066359 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1066361 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.s.IndexSchema [collection5] Schema name=tiny
   [junit4]   2> 1066362 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1066363 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.s.IndexSchema [collection2] Schema name=tiny
   [junit4]   2> 1066363 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5'
   [junit4]   2> 1066363 INFO  (coreLoadExecutor-4883-thread-3) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection5' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5
   [junit4]   2> 1066363 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1066364 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrCore [[collection5] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/data/]
   [junit4]   2> 1066364 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection5
   [junit4]   2> 1066364 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/data
   [junit4]   2> 1066364 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/data/index/
   [junit4]   2> 1066364 WARN  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrCore [collection5] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1066364 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/data/index
   [junit4]   2> 1066364 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=39, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2386206661874497]
   [junit4]   2> 1066365 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1066365 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default 
properties: Can't find resource 'configsetprops.json' in classpath or 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2'
   [junit4]   2> 1066365 INFO  (coreLoadExecutor-4883-thread-2) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection2' using configuration from 
instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2
   [junit4]   2> 1066365 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1066366 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrCore [[collection2] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2/data/]
   [junit4]   2> 1066366 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrCore JMX monitoring not detected for core: 
collection2
   [junit4]   2> 1066366 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2/data
   [junit4]   2> 1066366 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrCore New index directory detected: old=null 
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2/data/index/
   [junit4]   2> 1066366 WARN  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrCore [collection2] Solr index directory 
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1066366 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.CachingDirectoryFactory return new directory for 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2/data/index
   [junit4]   2> 1066366 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@586a0816 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@650591cb),segFN=segments_1,generation=1}
   [junit4]   2> 1066366 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1066371 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 1066373 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066373 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066373 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066374 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066374 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@5c736c49 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4ead1dfa),segFN=segments_1,generation=1}
   [junit4]   2> 1066374 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1066375 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,/update/csv,/update/json/docs,/admin/luke,/select,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 1066375 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1066375 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] 
o.a.s.c.SolrCore Looking for old index directories to cleanup for core 
collection1 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/data/
   [junit4]   2> 1066375 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection1) [    x:collection1] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 1066377 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=39, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.2386206661874497]
   [junit4]   2> 1066378 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@5d933b5e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@732f7b2f),segFN=segments_1,generation=1}
   [junit4]   2> 1066378 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1066386 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 1066387 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066388 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066388 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066388 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066389 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,/update/csv,/update/json/docs,/admin/luke,/select,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 1066389 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1066394 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection5) [    x:collection5] 
o.a.s.c.SolrCore Looking for old index directories to cleanup for core 
collection5 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/data/
   [junit4]   2> 1066394 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection5) [    x:collection5] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 1066398 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1066398 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1066398 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=25, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.478491552515793]
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrCore no updateRequestProcessorChain defined as 
default, creating implicit default
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@586a0816 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@650591cb),segFN=segments_1,generation=1}
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6443c50e[collection1] 
main
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/conf
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/conf}
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection1/conf
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1066399 INFO  (coreLoadExecutor-4883-thread-1) [    
x:collection1] o.a.s.c.CoreContainer registering core: collection1
   [junit4]   2> 1066400 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066400 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066400 INFO  
(searcherExecutor-4884-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@6443c50e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1066401 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1066401 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,/update/csv,/update/json/docs,/admin/luke,/select,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
   [junit4]   2> 1066401 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrCore Using default statsCache cache: 
org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1066402 INFO  
(OldIndexDirectoryCleanupThreadForCore-collection2) [    x:collection2] 
o.a.s.c.SolrCore Looking for old index directories to cleanup for core 
collection2 in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2/data/
   [junit4]   2> 1066402 WARN  
(OldIndexDirectoryCleanupThreadForCore-collection2) [    x:collection2] 
o.a.s.c.DirectoryFactory 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection2/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 1066406 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1066406 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1066406 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=25, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.478491552515793]
   [junit4]   2> 1066406 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@5c736c49 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4ead1dfa),segFN=segments_1,generation=1}
   [junit4]   2> 1066407 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1066407 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.s.SolrIndexSearcher Opening Searcher@7b831aad[collection5] 
main
   [junit4]   2> 1066407 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/conf
   [junit4]   2> 1066407 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/conf}
   [junit4]   2> 1066407 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build/solr-core/test/J1/temp/solr.core.TestLazyCores_7F5E2DD882F4730-001/tempDir-001/collection5/conf
   [junit4]   2> 1066407 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1066407 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1066407 INFO  (coreLoadExecutor-4883-thread-3) [    
x:collection5] o.a.s.c.CoreContainer registering core: collection5
   [junit4]   2> 1066414 INFO  
(searcherExecutor-4885-thread-1-processing-x:collection5) [    x:collection5] 
o.a.s.c.SolrCore [collection5] Registered new searcher 
Searcher@7b831aad[collection5] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1066414 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1066414 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1066415 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=25, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.478491552515793]
   [junit4]   2> 1066415 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@5d933b5e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@732f7b2f),segFN=segments_1,generation=1}
   [junit4]   2> 1066415 INFO  (coreLoadExecutor-4883-thread-2) [    
x:collection2] o.a.s.c.Solr

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

ckThreadLeaks
   [junit4]   2> SEVERE: 1 thread leaked from SUITE scope at 
org.apache.solr.core.TestLazyCores: 
   [junit4]   2>    1) Thread[id=10853, name=searcherExecutor-4886-thread-1, 
state=WAITING, group=TGRP-TestLazyCores]
   [junit4]   2>         at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
   [junit4]   2>         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
   [junit4]   2>         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> May 05, 2016 7:08:32 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: Starting to interrupt leaked threads:
   [junit4]   2>    1) Thread[id=10853, name=searcherExecutor-4886-thread-1, 
state=WAITING, group=TGRP-TestLazyCores]
   [junit4]   2> May 05, 2016 7:08:35 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> SEVERE: There are still zombie threads that couldn't be 
terminated:
   [junit4]   2>    1) Thread[id=10853, name=searcherExecutor-4886-thread-1, 
state=WAITING, group=TGRP-TestLazyCores]
   [junit4]   2>         at sun.misc.Unsafe.park(Native Method)
   [junit4]   2>         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
   [junit4]   2>         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
   [junit4]   2>         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
   [junit4]   2>         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>         at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> NOTE: test params are: 
codec=HighCompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=4, maxDocsPerChunk=129, blockSize=8), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=HIGH_COMPRESSION,
 chunkSize=4, blockSize=8)), sim=RandomSimilarity(queryNorm=false,coord=no): 
{}, locale=ro, timezone=US/Indiana-Starke
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_74 (64-bit)/cpus=4,threads=2,free=144349520,total=531628032
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestRandomRequestDistribution, ShardRoutingTest, TestSchemaNameResource, 
TestSolrCloudWithKerberosAlt, ZkSolrClientTest, SimpleMLTQParserTest, 
MinimalSchemaTest, FileUtilsTest, HdfsDirectoryTest, 
TestSolrConfigHandlerCloud, ConvertedLegacyTest, RequestLoggingTest, 
TestManagedSchemaFieldResource, AddSchemaFieldsUpdateProcessorFactoryTest, 
MBeansHandlerTest, ConcurrentDeleteAndCreateCollectionTest, 
AliasIntegrationTest, AnalysisErrorHandlingTest, 
TestCloudManagedSchemaConcurrent, BlockJoinFacetRandomTest, RankQueryTest, 
SolrIndexSplitterTest, TestQuerySenderListener, 
CloudExitableDirectoryReaderTest, TestCoreContainer, DateRangeFieldTest, 
TestCodecSupport, LeaderInitiatedRecoveryOnCommitTest, TestDistributedGrouping, 
SolrPluginUtilsTest, TestSolrCLIRunExample, 
TestLMJelinekMercerSimilarityFactory, SpellCheckCollatorTest, 
BasicFunctionalityTest, TestNonDefinedSimilarityFactory, ZkControllerTest, 
TermsComponentTest, ReplicationFactorTest, TestRuleBasedAuthorizationPlugin, 
TestTrie, SSLMigrationTest, TestScoreJoinQPScore, MultiTermTest, 
TestHashPartitioner, TestFiltering, TestSimpleTrackingShardHandler, 
TestNRTOpen, SharedFSAutoReplicaFailoverTest, FastVectorHighlighterTest, 
DistanceFunctionTest, TestWordDelimiterFilterFactory, SpatialRPTFieldTypeTest, 
DistributedExpandComponentTest, TestCloudDeleteByQuery, SimplePostToolTest, 
TestExceedMaxTermLength, SolrIndexConfigTest, TestJsonFacets, 
PreAnalyzedUpdateProcessorTest, BlockCacheTest, SparseHLLTest, 
ChaosMonkeySafeLeaderTest, SpellPossibilityIteratorTest, 
TestBM25SimilarityFactory, TestSchemaVersionResource, FacetPivotSmallTest, 
TestDefaultStatsCache, TestReloadDeadlock, TestClusterStateMutator, 
DistributedTermsComponentTest, HdfsChaosMonkeyNothingIsSafeTest, 
DistributedMLTComponentTest, TestCursorMarkWithoutUniqueKey, 
SortByFunctionTest, DistributedFacetPivotSmallAdvancedTest, TestInitQParser, 
TestSortingResponseWriter, HdfsUnloadDistributedZkTest, 
TestDownShardTolerantSearch, TestFastLRUCache, 
BigEndianAscendingWordSerializerTest, DistribJoinFromCollectionTest, 
TestCollectionAPI, SpatialFilterTest, UpdateRequestProcessorFactoryTest, 
TestImplicitCoreProperties, TestExactStatsCache, TestBinaryResponseWriter, 
SolrInfoMBeanTest, TestDocumentBuilder, ClusterStateUpdateTest, 
HdfsRestartWhileUpdatingTest, DirectSolrSpellCheckerTest, 
TestDFRSimilarityFactory, CollectionsAPIDistributedZkTest, 
OpenCloseCoreStressTest, LeaderElectionIntegrationTest, TestRandomDVFaceting, 
ZkCLITest, TestFaceting, DistributedSpellCheckComponentTest, 
SpellCheckComponentTest, BadIndexSchemaTest, TestFunctionQuery, TestLazyCores]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestLazyCores 
-Dtests.seed=7F5E2DD882F4730 -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=ro -Dtests.timezone=US/Indiana-Starke -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J1 | TestLazyCores (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: ObjectTracker found 4 
object(s) that were not released!!! [SolrCore, MockDirectoryWrapper, 
MockDirectoryWrapper, MDCAwareThreadPoolExecutor]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([7F5E2DD882F4730]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:228)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)Throwable #2: 
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE 
scope at org.apache.solr.core.TestLazyCores: 
   [junit4]    >    1) Thread[id=10853, name=searcherExecutor-4886-thread-1, 
state=WAITING, group=TGRP-TestLazyCores]
   [junit4]    >         at sun.misc.Unsafe.park(Native Method)
   [junit4]    >         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
   [junit4]    >         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
   [junit4]    >         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]    >         at java.lang.Thread.run(Thread.java:745)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([7F5E2DD882F4730]:0)Throwable #3: 
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie 
threads that couldn't be terminated:
   [junit4]    >    1) Thread[id=10853, name=searcherExecutor-4886-thread-1, 
state=WAITING, group=TGRP-TestLazyCores]
   [junit4]    >         at sun.misc.Unsafe.park(Native Method)
   [junit4]    >         at 
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
   [junit4]    >         at 
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
   [junit4]    >         at 
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
   [junit4]    >         at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]    >         at java.lang.Thread.run(Thread.java:745)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([7F5E2DD882F4730]:0)
   [junit4] Completed [410/572 (2!)] on J1 in 149.39s, 8 tests, 1 failure, 2 
errors <<< FAILURES!

[...truncated 518 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/build.xml:750: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/build.xml:694: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/build.xml:59: 
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/build.xml:233:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/solr/common-build.xml:534:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/lucene/common-build.xml:1477:
 The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-5.5-Java8/lucene/common-build.xml:1033:
 There were test failures: 572 suites (7 ignored), 2293 tests, 3 suite-level 
errors, 1 error, 527 ignored (35 assumptions) [seed: 7F5E2DD882F4730]

Total time: 42 minutes 6 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any



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

Reply via email to