Build: http://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/1747/
Java: 32bit/jdk1.8.0_102 -client -XX:+UseConcMarkSweepGC

2 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.cloud.CleanupOldIndexTest

Error Message:
Suite timeout exceeded (>= 7200000 msec).

Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
        at __randomizedtesting.SeedInfo.seed([7AB6C95193CFF544]:0)


FAILED:  org.apache.solr.cloud.CleanupOldIndexTest.test

Error Message:
Test abandoned because suite timeout was reached.

Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
        at __randomizedtesting.SeedInfo.seed([7AB6C95193CFF544]:0)




Build Log:
[...truncated 12788 lines...]
   [junit4] Suite: org.apache.solr.cloud.CleanupOldIndexTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/init-core-data-001
   [junit4]   2> 1344833 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1344837 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1344837 INFO  (Thread-2457) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1344837 INFO  (Thread-2457) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1344937 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:39643
   [junit4]   2> 1344938 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1344938 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1344940 INFO  (zkCallback-1569-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1905309 name:ZooKeeperConnection 
Watcher:127.0.0.1:39643 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1344940 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1344940 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1344940 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
   [junit4]   2> 1344942 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient makePath: /solr/clusterprops.json
   [junit4]   2> 1344945 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1344945 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1344946 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6042f3{/solr,null,AVAILABLE}
   [junit4]   2> 1344946 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1c22583{/solr,null,AVAILABLE}
   [junit4]   2> 1344951 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.e.j.s.ServerConnector Started ServerConnector@1752c3e{SSL,[ssl, 
http/1.1]}{127.0.0.1:44325}
   [junit4]   2> 1344951 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.e.j.s.ServerConnector Started ServerConnector@9241af{SSL,[ssl, 
http/1.1]}{127.0.0.1:45807}
   [junit4]   2> 1344951 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.e.j.s.Server Started @1346322ms
   [junit4]   2> 1344951 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.e.j.s.Server Started @1346322ms
   [junit4]   2> 1344951 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=44325}
   [junit4]   2> 1344951 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=45807}
   [junit4]   2> 1344951 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@1d16e93
   [junit4]   2> 1344951 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): 
sun.misc.Launcher$AppClassLoader@1d16e93
   [junit4]   2> 1344951 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1'
   [junit4]   2> 1344952 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2'
   [junit4]   2> 1344952 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1344952 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1344952 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
   [junit4]   2> 1344952 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find 
system property or JNDI)
   [junit4]   2> 1344952 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1344952 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1344952 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1344952 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1344953 INFO  (zkCallback-1570-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@1794979 name:ZooKeeperConnection 
Watcher:127.0.0.1:39643/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1344953 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1344954 INFO  (zkCallback-1571-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@189e09f name:ZooKeeperConnection 
Watcher:127.0.0.1:39643/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1344954 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1344954 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1344954 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1344954 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1344954 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1344964 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/.
   [junit4]   2> 1344964 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.CoreContainer New CoreContainer 11266712
   [junit4]   2> 1344964 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1]
   [junit4]   2> 1344964 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.CorePropertiesLocator Config-defined core root directory: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/.
   [junit4]   2> 1344964 WARN  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/lib
 to classpath: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/lib
   [junit4]   2> 1344965 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.CoreContainer New CoreContainer 32568853
   [junit4]   2> 1344965 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.CoreContainer Loading cores into CoreContainer 
[instanceDir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2]
   [junit4]   2> 1344965 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme 
: https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : 
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
   [junit4]   2> 1344965 WARN  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.CoreContainer Couldn't add files from 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/lib
 to classpath: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/lib
   [junit4]   2> 1344965 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme 
: https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : 
false,connectionsEvictorSleepDelay : 5000,maxConnectionIdleTime : 40000,
   [junit4]   2> 1344966 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1344967 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1344967 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1344967 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1344967 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39643/solr
   [junit4]   2> 1344967 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 1344967 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1344968 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1344968 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
   [junit4]   2> 1344968 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.l.LogWatcher Registering Log Listener [Log4j 
(org.slf4j.impl.Log4jLoggerFactory)]
   [junit4]   2> 1344968 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:39643/solr
   [junit4]   2> 1344968 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.ZkController zkHost includes chroot
   [junit4]   2> 1344968 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1344968 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1344968 INFO  (zkCallback-1576-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@116c071 name:ZooKeeperConnection 
Watcher:127.0.0.1:39643 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1344969 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1344969 INFO  (jetty-launcher-1568-thread-1) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1344969 INFO  (zkCallback-1577-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@9bdf41 name:ZooKeeperConnection 
Watcher:127.0.0.1:39643 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1344969 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1344969 INFO  (jetty-launcher-1568-thread-2) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1344970 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.ZkController Added new OnReconnect 
listener org.apache.solr.cloud.ZkController$$Lambda$47/31286542@824c54
   [junit4]   2> 1344970 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1344970 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.ZkController Added new OnReconnect 
listener org.apache.solr.cloud.ZkController$$Lambda$47/31286542@146af09
   [junit4]   2> 1344970 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ConnectionManager Waiting for client to 
connect to ZooKeeper
   [junit4]   2> 1344971 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@667629 name:ZooKeeperConnection 
Watcher:127.0.0.1:39643/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1344971 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 1344971 INFO  
(zkCallback-1579-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@14d2f28 name:ZooKeeperConnection 
Watcher:127.0.0.1:39643/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1344971 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ConnectionManager Client is connected to 
ZooKeeper
   [junit4]   2> 1344972 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 1344972 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
   [junit4]   2> 1344973 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 1344973 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-queue-work
   [junit4]   2> 1344976 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 1344976 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running
   [junit4]   2> 1344977 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 1344977 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-completed
   [junit4]   2> 1344978 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 1344978 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-failure
   [junit4]   2> 1344979 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1344979 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
   [junit4]   2> 1344980 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1344980 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: /collections
   [junit4]   2> 1344980 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1344980 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
   [junit4]   2> 1344981 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1344981 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
   [junit4]   2> 1344982 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1344982 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: /security.json
   [junit4]   2> 1344982 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 1344982 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader Updating cluster state 
from ZooKeeper... 
   [junit4]   2> 1344983 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader Loaded cluster properties: 
{urlScheme=https}
   [junit4]   2> 1344983 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader Loaded cluster properties: 
{urlScheme=https}
   [junit4]   2> 1344983 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 1344983 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (0)
   [junit4]   2> 1344984 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 1344984 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
   [junit4]   2> 1344985 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 1344986 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/election
   [junit4]   2> 1344987 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1344987 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1344987 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.LeaderElector Joined leadership election 
with path: 
/overseer_elect/election/96615963375501318-127.0.0.1:45807_solr-n_0000000000
   [junit4]   2> 1344987 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.LeaderElector Joined leadership election 
with path: 
/overseer_elect/election/96615963375501317-127.0.0.1:44325_solr-n_0000000001
   [junit4]   2> 1344987 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:45807_solr
   [junit4]   2> 1344987 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer_elect/leader
   [junit4]   2> 1344987 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.LeaderElector Watching path 
/overseer_elect/election/96615963375501318-127.0.0.1:45807_solr-n_0000000000 to 
know if I could be the leader
   [junit4]   2> 1344988 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44325_solr
   [junit4]   2> 1344988 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:44325_solr
   [junit4]   2> 1344988 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.Overseer Overseer 
(id=96615963375501318-127.0.0.1:45807_solr-n_0000000000) starting
   [junit4]   2> 1344988 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader A live node change: 
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], 
has occurred - updating... (live nodes size: [0])
   [junit4]   2> 1344988 INFO  
(zkCallback-1579-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader A live node change: 
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], 
has occurred - updating... (live nodes size: [0])
   [junit4]   2> 1344989 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1344989 INFO  
(zkCallback-1579-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1344990 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/queue-work
   [junit4]   2> 1344993 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting 
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 
autoReplicaFailoverWaitAfterExpiration=30000 
autoReplicaFailoverBadNodeExpiration=60000
   [junit4]   2> 1344993 INFO  
(OverseerCollectionConfigSetProcessor-96615963375501318-127.0.0.1:45807_solr-n_0000000000)
 [n:127.0.0.1:45807_solr    ] o.a.s.c.OverseerTaskProcessor Process current 
queue of overseer operations
   [junit4]   2> 1344995 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.Overseer Starting to work on the main queue
   [junit4]   2> 1344995 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.ZkController Publish 
node=127.0.0.1:45807_solr as DOWN
   [junit4]   2> 1344996 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (1)
   [junit4]   2> 1344996 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45807_solr
   [junit4]   2> 1344996 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/live_nodes/127.0.0.1:45807_solr
   [junit4]   2> 1344998 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"downnode",
   [junit4]   2>   "node_name":"127.0.0.1:45807_solr"} current state version: 0
   [junit4]   2> 1344998 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.o.NodeMutator DownNode state invoked for 
node: 127.0.0.1:45807_solr
   [junit4]   2> 1344998 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader A live node change: 
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], 
has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1344998 INFO  
(zkCallback-1579-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader A live node change: 
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], 
has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1344999 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1344999 INFO  
(zkCallback-1579-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1345028 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 1345028 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.CoreContainer No authentication plugin 
used.
   [junit4]   2> 1345029 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/.
   [junit4]   2> 1345029 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions
   [junit4]   2> 1345030 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.s.SolrDispatchFilter 
user.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 1345030 INFO  (jetty-launcher-1568-thread-1) 
[n:127.0.0.1:44325_solr    ] o.a.s.s.SolrDispatchFilter 
SolrDispatchFilter.init() done
   [junit4]   2> 1345047 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.CoreContainer Security conf doesn't exist. 
Skipping setup for authorization module.
   [junit4]   2> 1345047 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.CoreContainer No authentication plugin 
used.
   [junit4]   2> 1345048 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.CorePropertiesLocator Looking for core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/.
   [junit4]   2> 1345048 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions
   [junit4]   2> 1345048 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.s.SolrDispatchFilter 
user.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 1345048 INFO  (jetty-launcher-1568-thread-2) 
[n:127.0.0.1:45807_solr    ] o.a.s.s.SolrDispatchFilter 
SolrDispatchFilter.init() done
   [junit4]   2> 1345048 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1345049 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1345050 INFO  (zkCallback-1582-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@f6538b name:ZooKeeperConnection 
Watcher:127.0.0.1:39643 got event WatchedEvent state:SyncConnected type:None 
path:null path:null type:None
   [junit4]   2> 1345050 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1345050 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1345051 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
   [junit4]   2> 1345052 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 1345052 INFO  (zkCallback-1585-thread-1) [    ] 
o.a.s.c.c.ConnectionManager Watcher 
org.apache.solr.common.cloud.ConnectionManager@19398e7 name:ZooKeeperConnection 
Watcher:127.0.0.1:39643/solr got event WatchedEvent state:SyncConnected 
type:None path:null path:null type:None
   [junit4]   2> 1345052 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 1345052 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
   [junit4]   2> 1345053 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... 
   [junit4]   2> 1345053 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.ZkStateReader Loaded cluster properties: {urlScheme=https}
   [junit4]   2> 1345053 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1345054 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
   [junit4]   2> 1345056 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
   [junit4]   2> 1345070 INFO  
(TEST-CleanupOldIndexTest.test-seed#[7AB6C95193CFF544]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1345185 INFO  (qtp17384406-9607) [n:127.0.0.1:44325_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
async=9578a35a-2242-432e-9856-a8bf7c3e7f31&replicationFactor=2&collection.configName=conf1&name=oldindextest&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1345186 INFO  (qtp17384406-9607) [n:127.0.0.1:44325_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={async=9578a35a-2242-432e-9856-a8bf7c3e7f31&replicationFactor=2&collection.configName=conf1&name=oldindextest&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 1345186 INFO  
(OverseerCollectionConfigSetProcessor-96615963375501318-127.0.0.1:45807_solr-n_0000000000)
 [n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/overseer/collection-map-running/mn-9578a35a-2242-432e-9856-a8bf7c3e7f31
   [junit4]   2> 1345187 INFO  
(OverseerCollectionConfigSetProcessor-96615963375501318-127.0.0.1:45807_solr-n_0000000000)
 [n:127.0.0.1:45807_solr    ] o.a.s.c.OverseerTaskProcessor Overseer Collection 
Message Handler: Get the message 
id:/overseer/collection-queue-work/qn-0000000000 message:{
   [junit4]   2>   "name":"oldindextest",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "collection.configName":"conf1",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "async":"9578a35a-2242-432e-9856-a8bf7c3e7f31",
   [junit4]   2>   "operation":"create"}
   [junit4]   2> 1345187 INFO  
(OverseerThreadFactory-5028-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.OverseerCollectionMessageHandler 
OverseerCollectionMessageHandler.processMessage : create , {
   [junit4]   2>   "name":"oldindextest",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "collection.configName":"conf1",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "async":"9578a35a-2242-432e-9856-a8bf7c3e7f31",
   [junit4]   2>   "operation":"create"}
   [junit4]   2> 1345188 INFO  
(OverseerThreadFactory-5028-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
oldindextest
   [junit4]   2> 1345188 INFO  
(OverseerThreadFactory-5028-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.OverseerCollectionMessageHandler creating 
collections conf node /collections/oldindextest 
   [junit4]   2> 1345188 INFO  
(OverseerThreadFactory-5028-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.SolrZkClient makePath: 
/collections/oldindextest
   [junit4]   2> 1345189 INFO  
(zkCallback-1579-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader A collections change: 
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], 
has occurred - updating...
   [junit4]   2> 1345189 INFO  (zkCallback-1585-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected 
type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 1345189 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader A collections change: 
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], 
has occurred - updating...
   [junit4]   2> 1345192 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "name":"oldindextest",
   [junit4]   2>   "fromApi":"true",
   [junit4]   2>   "replicationFactor":"2",
   [junit4]   2>   "collection.configName":"conf1",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "stateFormat":"2",
   [junit4]   2>   "async":"9578a35a-2242-432e-9856-a8bf7c3e7f31",
   [junit4]   2>   "operation":"create"} current state version: 0
   [junit4]   2> 1345192 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.o.ClusterStateMutator building a new 
cName: oldindextest
   [junit4]   2> 1345192 INFO  (qtp17384406-9607) [n:127.0.0.1:44325_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=9578a35a-2242-432e-9856-a8bf7c3e7f31&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1345193 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.o.ZkStateWriter going to create_collection 
/collections/oldindextest/state.json
   [junit4]   2> 1345193 INFO  (qtp17384406-9607) [n:127.0.0.1:44325_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=9578a35a-2242-432e-9856-a8bf7c3e7f31&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1345292 INFO  
(OverseerThreadFactory-5028-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.CreateCollectionCmd Creating SolrCores for 
new collection oldindextest, shardNames [shard1] , replicationFactor : 2
   [junit4]   2> 1345292 INFO  
(OverseerThreadFactory-5028-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.CreateCollectionCmd Creating core 
oldindextest_shard1_replica2 as part of shard shard1 of collection oldindextest 
on 127.0.0.1:44325_solr
   [junit4]   2> 1345293 INFO  
(OverseerThreadFactory-5028-thread-1-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.CreateCollectionCmd Creating core 
oldindextest_shard1_replica1 as part of shard shard1 of collection oldindextest 
on 127.0.0.1:45807_solr
   [junit4]   2> 1345300 INFO  (qtp17384406-9611) [n:127.0.0.1:44325_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={async=9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815&qt=/admin/cores&collection.configName=conf1&name=oldindextest_shard1_replica2&action=CREATE&numShards=1&collection=oldindextest&shard=shard1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1345300 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr    ] o.a.s.h.a.CoreAdminOperation core create command 
async=9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815&qt=/admin/cores&collection.configName=conf1&name=oldindextest_shard1_replica2&action=CREATE&numShards=1&collection=oldindextest&shard=shard1&wt=javabin&version=2
   [junit4]   2> 1345301 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{name=oldindextest_shard1_replica2, collection.configName=conf1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, collection=oldindextest, numShards=1, 
dataDir=data/, shard=shard1}
   [junit4]   2> 1345301 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.ZkController publishing state=down
   [junit4]   2> 1345302 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.ZkController Registering watch for 
collection oldindextest
   [junit4]   2> 1345302 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "core":"oldindextest_shard1_replica2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:44325/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:44325_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"oldindextest",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1345302 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.c.ZkStateReader Add data for 
[oldindextest] ver [0]
   [junit4]   2> 1345302 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"oldindextest_shard1_replica2",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:44325/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:44325_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"oldindextest",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1345302 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.ZkController look for our core node name
   [junit4]   2> 1345405 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/oldindextest/state.json version: 0
   [junit4]   2> 1345406 INFO  (qtp1415500-9606) [n:127.0.0.1:45807_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={async=9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124&qt=/admin/cores&collection.configName=conf1&name=oldindextest_shard1_replica1&action=CREATE&numShards=1&collection=oldindextest&shard=shard1&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1345406 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/oldindextest/state.json] for collection [oldindextest] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1345406 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr    ] o.a.s.h.a.CoreAdminOperation core create command 
async=9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124&qt=/admin/cores&collection.configName=conf1&name=oldindextest_shard1_replica1&action=CREATE&numShards=1&collection=oldindextest&shard=shard1&wt=javabin&version=2
   [junit4]   2> 1345407 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader Updating data for 
[oldindextest] from [0] to [1]
   [junit4]   2> 1345407 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.CoreDescriptor Created CoreDescriptor: 
{name=oldindextest_shard1_replica1, collection.configName=conf1, 
config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, 
configSetProperties=configsetprops.json, collection=oldindextest, numShards=1, 
dataDir=data/, shard=shard1}
   [junit4]   2> 1345407 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.ZkController publishing state=down
   [junit4]   2> 1345408 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.ZkController Registering watch for 
collection oldindextest
   [junit4]   2> 1345408 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "core":"oldindextest_shard1_replica1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:45807/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:45807_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"oldindextest",
   [junit4]   2>   "operation":"state"} current state version: 0
   [junit4]   2> 1345408 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.o.ReplicaMutator Update state numShards=1 
message={
   [junit4]   2>   "core":"oldindextest_shard1_replica1",
   [junit4]   2>   "roles":null,
   [junit4]   2>   "base_url":"https://127.0.0.1:45807/solr";,
   [junit4]   2>   "node_name":"127.0.0.1:45807_solr",
   [junit4]   2>   "numShards":"1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"oldindextest",
   [junit4]   2>   "operation":"state"}
   [junit4]   2> 1345409 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.c.ZkStateReader Add data for 
[oldindextest] ver [1]
   [junit4]   2> 1345409 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.ZkController look for our core node name
   [junit4]   2> 1345411 INFO  (qtp17384406-9611) [n:127.0.0.1:44325_solr    ] 
o.a.s.h.a.CoreAdminOperation Checking request status for : 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815
   [junit4]   2> 1345411 INFO  (qtp17384406-9611) [n:127.0.0.1:44325_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1345510 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.o.ZkStateWriter going to update_collection 
/collections/oldindextest/state.json version: 1
   [junit4]   2> 1345511 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/oldindextest/state.json] for collection [oldindextest] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1345511 INFO  
(zkCallback-1579-thread-2-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/oldindextest/state.json] for collection [oldindextest] has 
occurred - updating... (live nodes size: [2])
   [junit4]   2> 1345511 INFO  
(zkCallback-1578-thread-1-processing-n:127.0.0.1:44325_solr) 
[n:127.0.0.1:44325_solr    ] o.a.s.c.c.ZkStateReader Updating data for 
[oldindextest] from [1] to [2]
   [junit4]   2> 1345511 INFO  
(zkCallback-1579-thread-2-processing-n:127.0.0.1:45807_solr) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.c.ZkStateReader Updating data for 
[oldindextest] from [1] to [2]
   [junit4]   2> 1346199 INFO  (qtp17384406-9611) [n:127.0.0.1:44325_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=9578a35a-2242-432e-9856-a8bf7c3e7f31&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1346199 INFO  (qtp17384406-9611) [n:127.0.0.1:44325_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=9578a35a-2242-432e-9856-a8bf7c3e7f31&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1346303 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.ZkController waiting to find shard id 
in clusterstate for oldindextest_shard1_replica2
   [junit4]   2> 1346303 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.ZkController Check for collection 
zkNode:oldindextest
   [junit4]   2> 1346303 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 1346303 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.SolrResourceLoader new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/oldindextest_shard1_replica2'
   [junit4]   2> 1346304 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.SolrResourceLoader JNDI not configured 
for solr (NoInitialContextEx)
   [junit4]   2> 1346304 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.SolrResourceLoader solr home defaulted 
to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1346305 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.Config loaded config solrconfig.xml 
with version 0 
   [junit4]   2> 1346309 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.SolrConfig current version of 
requestparams : -1
   [junit4]   2> 1346313 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 
6.3.0
   [junit4]   2> 1346320 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.SolrConfig Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 1346328 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.s.IndexSchema 
[oldindextest_shard1_replica2] Schema name=cloud-dynamic
   [junit4]   2> 1346356 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.s.IndexSchema default search field in 
schema is text
   [junit4]   2> 1346357 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1346359 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.ConfigSetProperties Did not find 
ConfigSet properties, assuming default properties: Can't find resource 
'configsetprops.json' in classpath or '/configs/conf1', 
cwd=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 1346359 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica2] o.a.s.c.CoreContainer Creating SolrCore 
'oldindextest_shard1_replica2' using configuration from collection oldindextest
   [junit4]   2> 1346359 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrCore 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1346359 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrCore 
[[oldindextest_shard1_replica2] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/oldindextest_shard1_replica2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/]
   [junit4]   2> 1346359 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrCore JMX monitoring not detected 
for core: oldindextest_shard1_replica2
   [junit4]   2> 1346360 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.CachingDirectoryFactory return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/snapshot_metadata
   [junit4]   2> 1346360 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.s.SolrSnapshotMetaDataManager Loading 
from snapshot metadata file...
   [junit4]   2> 1346360 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.CachingDirectoryFactory return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data
   [junit4]   2> 1346360 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrCore New index directory detected: 
old=null 
new=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/index/
   [junit4]   2> 1346360 WARN  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrCore [oldindextest_shard1_replica2] 
Solr index directory 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1346361 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.CachingDirectoryFactory return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/index
   [junit4]   2> 1346361 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrDeletionPolicy 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@12952a4 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5cfe1a),segFN=segments_1,generation=1}
   [junit4]   2> 1346361 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrDeletionPolicy newest commit 
generation = 1
   [junit4]   2> 1346362 INFO  
(OldIndexDirectoryCleanupThreadForCore-oldindextest_shard1_replica2) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrCore Looking for old index 
directories to cleanup for core oldindextest_shard1_replica2 in 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/
   [junit4]   2> 1346362 WARN  
(OldIndexDirectoryCleanupThreadForCore-oldindextest_shard1_replica2) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.DirectoryFactory 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 1346363 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrCore no updateRequestProcessorChain 
defined as default, creating implicit default
   [junit4]   2> 1346364 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1346366 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1346367 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1346368 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1346369 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/select,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 1346370 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrCore Using default statsCache 
cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1346370 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1346370 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1346371 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1346371 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1346371 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrDeletionPolicy 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@12952a4 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5cfe1a),segFN=segments_1,generation=1}
   [junit4]   2> 1346371 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.SolrDeletionPolicy newest commit 
generation = 1
   [junit4]   2> 1346371 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@9fe7d9[oldindextest_shard1_replica2] main]
   [junit4]   2> 1346372 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.r.ManagedResourceStorage Setting up 
ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 1346372 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.r.ManagedResourceStorage Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1346372 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.r.RestManager Initializing RestManager 
with initArgs: {}
   [junit4]   2> 1346372 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.r.ManagedResourceStorage Reading 
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1346373 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.r.ManagedResourceStorage No data found 
for znode /configs/conf1/_rest_managed.json
   [junit4]   2> 1346373 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.r.ManagedResourceStorage Loaded null at 
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1346373 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.r.RestManager Initializing 0 registered 
ManagedResources
   [junit4]   2> 1346373 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.h.ReplicationHandler Commits will be 
reserved for  10000
   [junit4]   2> 1346373 INFO  
(searcherExecutor-5033-thread-1-processing-x:oldindextest_shard1_replica2 
r:core_node1 9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE 
n:127.0.0.1:44325_solr s:shard1 c:oldindextest) [n:127.0.0.1:44325_solr 
c:oldindextest s:shard1 r:core_node1 x:oldindextest_shard1_replica2] 
o.a.s.c.SolrCore [oldindextest_shard1_replica2] Registered new searcher 
Searcher@9fe7d9[oldindextest_shard1_replica2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1346373 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.u.UpdateLog Looking up max value of 
version field to seed version buckets
   [junit4]   2> 1346373 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.u.VersionInfo Refreshing highest value of 
_version_ for 65536 version buckets from index
   [junit4]   2> 1346373 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.u.VersionInfo No terms found for 
_version_, cannot seed version bucket highest value from index
   [junit4]   2> 1346373 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.u.UpdateLog Could not find max version in 
index or recent updates, using new clock 1545855415617585152
   [junit4]   2> 1346375 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.u.UpdateLog Took 1.0ms to seed version 
buckets with highest version 1545855415617585152
   [junit4]   2> 1346375 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.ZkController watch zkdir /configs/conf1
   [junit4]   2> 1346375 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.CoreContainer registering core: 
oldindextest_shard1_replica2
   [junit4]   2> 1346376 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.ZkController Register replica - 
core:oldindextest_shard1_replica2 address:https://127.0.0.1:44325/solr 
collection:oldindextest shard:shard1
   [junit4]   2> 1346376 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.c.SolrZkClient makePath: 
/collections/oldindextest/leader_elect/shard1/election
   [junit4]   2> 1346378 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.LeaderElector Joined leadership 
election with path: 
/collections/oldindextest/leader_elect/shard1/election/96615963375501317-core_node1-n_0000000000
   [junit4]   2> 1346378 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.ShardLeaderElectionContext Running the 
leader process for shard=shard1 and weAreReplacement=false and 
leaderVoteWait=10000
   [junit4]   2> 1346379 INFO  
(parallelCoreAdminExecutor-5029-thread-1-processing-n:127.0.0.1:44325_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815 CREATE) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.ShardLeaderElectionContext Waiting 
until we see more replicas up for shard shard1: total=2 found=1 timeoutin=9999ms
   [junit4]   2> 1346380 INFO  
(OverseerStateUpdate-96615963375501318-127.0.0.1:45807_solr-n_0000000000) 
[n:127.0.0.1:45807_solr    ] o.a.s.c.Overseer processMessage: queueSize: 1, 
message = {
   [junit4]   2>   "operation":"leader",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "collection":"oldindextest"} current state version: 0
   [junit4]   2> 1346409 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.ZkController waiting to find shard id 
in clusterstate for oldindextest_shard1_replica1
   [junit4]   2> 1346409 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.ZkController Check for collection 
zkNode:oldindextest
   [junit4]   2> 1346409 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.ZkController Collection zkNode exists
   [junit4]   2> 1346410 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.SolrResourceLoader new 
SolrResourceLoader for directory: 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/oldindextest_shard1_replica1'
   [junit4]   2> 1346410 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.SolrResourceLoader JNDI not configured 
for solr (NoInitialContextEx)
   [junit4]   2> 1346410 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.SolrResourceLoader solr home defaulted 
to 'solr/' (could not find system property or JNDI)
   [junit4]   2> 1346411 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.Config loaded config solrconfig.xml 
with version 0 
   [junit4]   2> 1346416 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.SolrConfig current version of 
requestparams : -1
   [junit4]   2> 1346416 INFO  (qtp17384406-9611) [n:127.0.0.1:44325_solr    ] 
o.a.s.h.a.CoreAdminOperation Checking request status for : 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815
   [junit4]   2> 1346420 INFO  (qtp17384406-9611) [n:127.0.0.1:44325_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=9578a35a-2242-432e-9856-a8bf7c3e7f311161775707440815&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=4
   [junit4]   2> 1346422 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 
6.3.0
   [junit4]   2> 1346428 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.SolrConfig Loaded SolrConfig: 
solrconfig.xml
   [junit4]   2> 1346434 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.s.IndexSchema 
[oldindextest_shard1_replica1] Schema name=cloud-dynamic
   [junit4]   2> 1346458 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.s.IndexSchema default search field in 
schema is text
   [junit4]   2> 1346458 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.s.IndexSchema unique key field: id
   [junit4]   2> 1346460 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.ConfigSetProperties Did not find 
ConfigSet properties, assuming default properties: Can't find resource 
'configsetprops.json' in classpath or '/configs/conf1', 
cwd=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1
   [junit4]   2> 1346460 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1  
x:oldindextest_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 
'oldindextest_shard1_replica1' using configuration from collection oldindextest
   [junit4]   2> 1346460 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrCore 
org.apache.solr.core.MockDirectoryFactory
   [junit4]   2> 1346460 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrCore 
[[oldindextest_shard1_replica1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/oldindextest_shard1_replica1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/./oldindextest_shard1_replica1/data/]
   [junit4]   2> 1346460 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrCore JMX monitoring not detected 
for core: oldindextest_shard1_replica1
   [junit4]   2> 1346461 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.CachingDirectoryFactory return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/./oldindextest_shard1_replica1/data/snapshot_metadata
   [junit4]   2> 1346461 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.s.SolrSnapshotMetaDataManager Loading 
from snapshot metadata file...
   [junit4]   2> 1346462 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.CachingDirectoryFactory return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/./oldindextest_shard1_replica1/data
   [junit4]   2> 1346462 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrCore New index directory detected: 
old=null 
new=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/./oldindextest_shard1_replica1/data/index/
   [junit4]   2> 1346462 WARN  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrCore [oldindextest_shard1_replica1] 
Solr index directory 
'/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/./oldindextest_shard1_replica1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1346462 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.CachingDirectoryFactory return new 
directory for 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/./oldindextest_shard1_replica1/data/index
   [junit4]   2> 1346463 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrDeletionPolicy 
SolrDeletionPolicy.onCommit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@192e28c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@cc36c3),segFN=segments_1,generation=1}
   [junit4]   2> 1346463 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrDeletionPolicy newest commit 
generation = 1
   [junit4]   2> 1346463 INFO  
(OldIndexDirectoryCleanupThreadForCore-oldindextest_shard1_replica1) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrCore Looking for old index 
directories to cleanup for core oldindextest_shard1_replica1 in 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/./oldindextest_shard1_replica1/data/
   [junit4]   2> 1346463 WARN  
(OldIndexDirectoryCleanupThreadForCore-oldindextest_shard1_replica1) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.DirectoryFactory 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/./oldindextest_shard1_replica1/data/
 does not point to a valid data directory; skipping clean-up of old index 
directories.
   [junit4]   2> 1346465 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrCore no updateRequestProcessorChain 
defined as default, creating implicit default
   [junit4]   2> 1346466 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1346466 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1346467 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1346468 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
   [junit4]   2> 1346469 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/select,/admin/segments,/admin/system,/replication,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 1346469 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrCore Using default statsCache 
cache: org.apache.solr.search.stats.LocalStatsCache
   [junit4]   2> 1346470 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1346470 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 1346470 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1346470 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1346471 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrDeletionPolicy 
SolrDeletionPolicy.onInit: commits: num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@192e28c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@cc36c3),segFN=segments_1,generation=1}
   [junit4]   2> 1346471 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.SolrDeletionPolicy newest commit 
generation = 1
   [junit4]   2> 1346471 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@104eeb4[oldindextest_shard1_replica1] main]
   [junit4]   2> 1346471 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.r.ManagedResourceStorage Setting up 
ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
   [junit4]   2> 1346472 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf1
   [junit4]   2> 1346472 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.r.RestManager Initializing RestManager 
with initArgs: {}
   [junit4]   2> 1346472 INFO  
(parallelCoreAdminExecutor-5031-thread-1-processing-n:127.0.0.1:45807_solr 
9578a35a-2242-432e-9856-a8bf7c3e7f311161775707714124 CREATE) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.r.ManagedResourceStorage Reading 
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1346472 INFO  (parallelCoreAdminExecutor-5031-thread-1-processi

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

solr c:oldindextest s:shard1 r:core_node1 x:oldindextest_shard1_replica2] 
o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data
   [junit4]   2> 8565631 INFO  (coreCloseExecutor-5058-thread-1) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.CachingDirectoryFactory Closing 
directory, CoreContainer#isShutdown=true
   [junit4]   2> 8565631 INFO  (coreCloseExecutor-5058-thread-1) 
[n:127.0.0.1:45807_solr c:oldindextest s:shard1 r:core_node2 
x:oldindextest_shard1_replica1] o.a.s.c.CachingDirectoryFactory Closing 
directory: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node2/./oldindextest_shard1_replica1/data
   [junit4]   2> 8565631 INFO  (coreCloseExecutor-5057-thread-1) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.CachingDirectoryFactory looking to 
close 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/index
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/index;done=false>>]
   [junit4]   2> 8565631 INFO  (coreCloseExecutor-5057-thread-1) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.CachingDirectoryFactory Closing 
directory, CoreContainer#isShutdown=true
   [junit4]   2> 8565631 INFO  (coreCloseExecutor-5057-thread-1) 
[n:127.0.0.1:44325_solr c:oldindextest s:shard1 r:core_node1 
x:oldindextest_shard1_replica2] o.a.s.c.CachingDirectoryFactory Closing 
directory: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001/tempDir-001/node1/./oldindextest_shard1_replica2/data/index
   [junit4]   2> 8565633 INFO  (jetty-launcher-1568-thread-4) [    ] 
o.a.s.c.Overseer Overseer 
(id=96615963375501318-127.0.0.1:45807_solr-n_0000000000) closing
   [junit4]   2> 8565633 INFO  (jetty-launcher-1568-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1c22583{/solr,null,UNAVAILABLE}
   [junit4]   2> 8565635 INFO  (jetty-launcher-1568-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@4a2d1c{/solr,null,UNAVAILABLE}
   [junit4]   2> 8565635 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:39643 39643
   [junit4]   2> 8565755 INFO  
(SUITE-CleanupOldIndexTest-seed#[7AB6C95193CFF544]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.CleanupOldIndexTest_7AB6C95193CFF544-001
   [junit4]   2> 8566125 WARN  
(TEST-CleanupOldIndexTest.test-seed#[7AB6C95193CFF544]-SendThread(127.0.0.1:39643))
 [n:127.0.0.1:44325_solr    ] o.a.z.c.StaticHostProvider Unexpected exception
   [junit4]   2> java.lang.InterruptedException: sleep interrupted
   [junit4]   2>        at java.lang.Thread.sleep(Native Method)
   [junit4]   2>        at 
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:101)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:940)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
   [junit4]   2> 8566125 WARN  
(jetty-launcher-1568-thread-2-SendThread(127.0.0.1:39643)) 
[n:127.0.0.1:45807_solr    ] o.a.z.c.StaticHostProvider Unexpected exception
   [junit4]   2> java.lang.InterruptedException: sleep interrupted
   [junit4]   2>        at java.lang.Thread.sleep(Native Method)
   [junit4]   2>        at 
org.apache.zookeeper.client.StaticHostProvider.next(StaticHostProvider.java:101)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:940)
   [junit4]   2>        at 
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1003)
   [junit4]   2> Sep 19, 2016 1:50:26 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
   [junit4]   2> INFO: All leaked threads terminated.
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): 
{rnd_b=PostingsFormat(name=MockRandom), 
_version_=PostingsFormat(name=Asserting), a_t=Lucene50(blocksize=128), 
a_i=PostingsFormat(name=MockRandom), id=PostingsFormat(name=MockRandom)}, 
docValues:{}, maxPointsInLeafNode=608, maxMBSortInHeap=7.431409622534496, 
sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=el-GR, 
timezone=America/Merida
   [junit4]   2> NOTE: Linux 4.4.0-36-generic i386/Oracle Corporation 1.8.0_102 
(32-bit)/cpus=12,threads=2,free=189001768,total=357089280
   [junit4]   2> NOTE: All tests run in this JVM: [CoreAdminCreateDiscoverTest, 
ClusterStateUpdateTest, IndexSchemaTest, TestPartialUpdateDeduplication, 
InfoHandlerTest, SuggesterFSTTest, TestRequestForwarding, 
TestLeaderElectionZkExpiry, TriLevelCompositeIdRoutingTest, 
TestConfigSetsAPIZkFailure, TestSearchPerf, DistributedTermsComponentTest, 
HdfsRecoveryZkTest, UpdateRequestProcessorFactoryTest, SampleTest, 
TestLRUStatsCache, TestInitParams, HdfsBasicDistributedZkTest, 
PeerSyncReplicationTest, BasicFunctionalityTest, 
TestCursorMarkWithoutUniqueKey, EnumFieldTest, HdfsLockFactoryTest, 
SearchHandlerTest, ReplaceNodeTest, DirectSolrConnectionTest, 
CdcrVersionReplicationTest, DistributedVersionInfoTest, 
TestRandomCollapseQParserPlugin, ZkStateReaderTest, 
CloneFieldUpdateProcessorFactoryTest, SchemaVersionSpecificBehaviorTest, 
TestFreeTextSuggestions, TestDFISimilarityFactory, 
TestComplexPhraseQParserPlugin, ChaosMonkeySafeLeaderTest, TermsComponentTest, 
RuleEngineTest, AsyncMigrateRouteKeyTest, 
ConcurrentDeleteAndCreateCollectionTest, HdfsCollectionsAPIDistributedZkTest, 
TestUpdate, TestEmbeddedSolrServerConstructors, TestRTGBase, 
TestSchemaNameResource, TestBM25SimilarityFactory, 
TestLMDirichletSimilarityFactory, TestFilteredDocIdSet, 
TestObjectReleaseTracker, TestCollationFieldDocValues, DeleteShardTest, 
MigrateRouteKeyTest, TestSortingResponseWriter, TestDistributedGrouping, 
TestTolerantUpdateProcessorCloud, TestSolrCloudWithKerberosAlt, JsonLoaderTest, 
TestSchemaManager, TestSimpleTrackingShardHandler, CdcrUpdateLogTest, 
TolerantUpdateProcessorTest, DistributedFacetPivotLargeTest, 
TestCustomDocTransformer, QueryResultKeyTest, AliasIntegrationTest, 
DistanceFunctionTest, TestCloudInspectUtil, DeleteLastCustomShardedReplicaTest, 
OpenCloseCoreStressTest, TestAddFieldRealTimeGet, TestDownShardTolerantSearch, 
SimpleCollectionCreateDeleteTest, TestFiltering, TestReplicationHandlerBackup, 
TestFieldCacheReopen, TestConfigSetImmutable, TestLegacyFieldCache, 
TestSimpleQParserPlugin, CSVRequestHandlerTest, ZkCLITest, SortByFunctionTest, 
TestRecoveryHdfs, MultiTermTest, RollingRestartTest, ChangedSchemaMergeTest, 
TestDynamicFieldCollectionResource, TestJsonFacets, 
DistributedDebugComponentTest, ShardRoutingTest, BlockDirectoryTest, 
DistributedMLTComponentTest, DistributedIntervalFacetingTest, 
TestSurroundQueryParser, BitVectorTest, TestRawResponseWriter, FileUtilsTest, 
CollectionsAPIDistributedZkTest, LoggingHandlerTest, 
DistributedFacetPivotSmallTest, TestIntervalFaceting, TestQuerySenderListener, 
TestSolrIndexConfig, UnloadDistributedZkTest, TestRandomFaceting, 
TestRandomDVFaceting, ShardRoutingCustomTest, ZkControllerTest, 
TestStressReorder, TestJoin, SolrCoreTest, SolrCmdDistributorTest, 
QueryElevationComponentTest, ConvertedLegacyTest, TestIndexSearcher, 
SoftAutoCommitTest, TestExtendedDismaxParser, TestFoldingMultitermQuery, 
DocValuesTest, QueryEqualityTest, TestSolrDeletionPolicy1, 
IndexBasedSpellCheckerTest, TestQueryUtils, TestWriterPerf, 
DocumentAnalysisRequestHandlerTest, PrimitiveFieldTypeTest, TestOmitPositions, 
DocumentBuilderTest, TermVectorComponentTest, MoreLikeThisHandlerTest, 
FieldAnalysisRequestHandlerTest, IndexSchemaRuntimeFieldTest, 
TestJmxIntegration, TestCSVResponseWriter, QueryParsingTest, 
TestPHPSerializedResponseWriter, TestComponentsName, TestBinaryResponseWriter, 
HighlighterConfigTest, AlternateDirectoryTest, CopyFieldTest, 
SolrIndexConfigTest, TestMergePolicyConfig, TestSolrDeletionPolicy2, 
TestBinaryField, NumericFieldsTest, MinimalSchemaTest, 
TestElisionMultitermQuery, TestFuzzyAnalyzedSuggestions, 
ExternalFileFieldSortTest, TestSolrCoreProperties, TestLuceneMatchVersion, 
TestPhraseSuggestions, TestCharFilters, TestCodecSupport, TestXIncludeConfig, 
EchoParamsTest, TestSweetSpotSimilarityFactory, 
TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, 
TimeZoneUtilsTest, TestFastOutputStream, OpenExchangeRatesOrgProviderTest, 
URLClassifyProcessorTest, DateMathParserTest, TestSystemIdResolver, 
DateFieldTest, RAMDirectoryFactoryTest, TestDocumentBuilder, SliceStateTest, 
UUIDFieldTest, SolrTestCaseJ4Test, TestCrossCoreJoin, 
TestHighlightDedupGrouping, TestTolerantSearch, ConnectionReuseTest, 
BaseCdcrDistributedZkTest, CdcrReplicationDistributedZkTest, 
CdcrRequestHandlerTest, CleanupOldIndexTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=CleanupOldIndexTest 
-Dtests.seed=7AB6C95193CFF544 -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=el-GR -Dtests.timezone=America/Merida -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   0.00s J1 | CleanupOldIndexTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 
7200000 msec).
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([7AB6C95193CFF544]:0)
   [junit4] Completed [630/630 (1!)] on J1 in 7221.42s, 1 test, 2 errors <<< 
FAILURES!

[...truncated 52606 lines...]

---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org

Reply via email to