You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2015/08/22 20:11:12 UTC
[JENKINS] Lucene-Solr-5.x-Linux (64bit/jdk1.8.0_60) - Build # 13680
- Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/13680/
Java: 64bit/jdk1.8.0_60 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.util.TestSolrCLIRunExample.testInteractiveSolrCloudExample
Error Message:
Could not find a healthy node to handle the request.
Stack Trace:
org.apache.solr.common.SolrException: Could not find a healthy node to handle the request.
at __randomizedtesting.SeedInfo.seed([DBF2204C7EC13CF1:83C08649B4F997]:0)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1071)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:857)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:940)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:940)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:940)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:940)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:940)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:800)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:135)
at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:485)
at org.apache.solr.client.solrj.SolrClient.commit(SolrClient.java:464)
at org.apache.solr.util.TestSolrCLIRunExample.testInteractiveSolrCloudExample(TestSolrCLIRunExample.java:443)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 9797 lines...]
[junit4] Suite: org.apache.solr.util.TestSolrCLIRunExample
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/init-core-data-001
[junit4] 2> 234517 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testInteractiveSolrCloudExample
[junit4] 2> 234545 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 234546 INFO (Thread-733) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 234546 INFO (Thread-733) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 234646 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.ZkTestServer start zk server on port:35645
[junit4] 2> 234646 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 234646 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 234648 INFO (zkCallback-286-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@15489ae5 name:ZooKeeperConnection Watcher:127.0.0.1:35645 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 234648 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 234649 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 234649 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml
[junit4] 2> 234652 INFO (jetty-launcher-285-thread-1) [ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 234653 INFO (jetty-launcher-285-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@249eda2f{/solr,null,AVAILABLE}
[junit4] 2> 234653 INFO (jetty-launcher-285-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@3255121a{HTTP/1.1}{127.0.0.1:34959}
[junit4] 2> 234653 INFO (jetty-launcher-285-thread-1) [ ] o.e.j.s.Server Started @236531ms
[junit4] 2> 234653 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=34959}
[junit4] 2> 234654 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 234654 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/'
[junit4] 2> 234662 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 234662 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 234663 INFO (zkCallback-287-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4750abdb name:ZooKeeperConnection Watcher:127.0.0.1:35645/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 234663 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 234664 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 234664 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 234668 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002
[junit4] 2> 234668 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 567500627
[junit4] 2> 234668 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/]
[junit4] 2> 234668 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.CoreContainer loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/lib
[junit4] 2> 234668 WARN (jetty-launcher-285-thread-1) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/lib).
[junit4] 2> 234673 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 234673 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=600000&connTimeout=60000&retry=true
[junit4] 2> 234674 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 234674 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 234674 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35645/solr
[junit4] 2> 234674 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 234674 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 234674 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 234675 INFO (zkCallback-289-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@40292b7e name:ZooKeeperConnection Watcher:127.0.0.1:35645 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 234676 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 234676 INFO (jetty-launcher-285-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 234677 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 234677 INFO (zkCallback-290-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@d232a17 name:ZooKeeperConnection Watcher:127.0.0.1:35645/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 234678 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 234678 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 234679 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 234680 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 234680 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 234681 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 234681 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 234682 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /collections
[junit4] 2> 234682 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 234682 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 234683 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 234683 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/localhost:34959_solr
[junit4] 2> 234683 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/localhost:34959_solr
[junit4] 2> 234684 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 234684 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 234685 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 234685 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94389258565713923-localhost:34959_solr-n_0000000000
[junit4] 2> 234685 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader localhost:34959_solr
[junit4] 2> 234685 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 234686 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.Overseer Overseer (id=94389258565713923-localhost:34959_solr-n_0000000000) starting
[junit4] 2> 234686 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 234689 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 234689 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 234689 INFO (OverseerCollectionProcessor-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.OverseerProcessor Process current queue of overseer operations
[junit4] 2> 234689 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 234703 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 234703 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 234704 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.CoresLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002
[junit4] 2> 234704 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.c.CoresLocator Found 0 core definitions
[junit4] 2> 234705 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 234705 INFO (jetty-launcher-285-thread-1) [n:localhost:34959_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 234705 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 234705 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 234706 INFO (zkCallback-291-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4228dc22 name:ZooKeeperConnection Watcher:127.0.0.1:35645 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 234706 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 234706 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 234726 INFO (qtp372715838-2049) [n:localhost:34959_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/info/system params={wt=json} status=0 QTime=15
[junit4] 2> 234730 INFO (qtp372715838-2050) [n:localhost:34959_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=json
[junit4] 2> 234732 INFO (qtp372715838-2050) [n:localhost:34959_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=json} status=0 QTime=2
[junit4] 2> 234733 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 234733 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 234734 INFO (zkCallback-294-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3729e865 name:ZooKeeperConnection Watcher:127.0.0.1:35645/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 234734 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 234734 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 234734 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 234737 INFO (qtp372715838-2049) [n:localhost:34959_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=list&wt=json
[junit4] 2> 234737 INFO (qtp372715838-2049) [n:localhost:34959_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/collections params={action=list&wt=json} status=0 QTime=0
[junit4] 2> 234742 INFO (qtp372715838-2051) [n:localhost:34959_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/info/system params={wt=json} status=0 QTime=2
[junit4] 2> 234745 INFO (qtp372715838-2049) [n:localhost:34959_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterstatus with params action=CLUSTERSTATUS&wt=json
[junit4] 2> 234746 INFO (qtp372715838-2049) [n:localhost:34959_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/collections params={action=CLUSTERSTATUS&wt=json} status=0 QTime=0
[junit4] 2> 234747 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 234748 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 234749 INFO (zkCallback-296-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5b5ea1fa name:ZooKeeperConnection Watcher:127.0.0.1:35645/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 234749 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 234749 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 234749 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 234751 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/protwords.txt
[junit4] 2> 234753 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/solrconfig.xml
[junit4] 2> 234754 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/stopwords.txt
[junit4] 2> 234755 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ar.txt
[junit4] 2> 234756 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_el.txt
[junit4] 2> 234756 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ja.txt
[junit4] 2> 234757 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_gl.txt
[junit4] 2> 234758 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/contractions_fr.txt
[junit4] 2> 234759 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_fr.txt
[junit4] 2> 234760 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_nl.txt
[junit4] 2> 234760 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_cz.txt
[junit4] 2> 234761 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ca.txt
[junit4] 2> 234762 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_de.txt
[junit4] 2> 234763 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/contractions_ga.txt
[junit4] 2> 234764 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_da.txt
[junit4] 2> 234764 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_no.txt
[junit4] 2> 234765 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_es.txt
[junit4] 2> 234766 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_sv.txt
[junit4] 2> 234767 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_fi.txt
[junit4] 2> 234768 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_hu.txt
[junit4] 2> 234769 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_bg.txt
[junit4] 2> 234769 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_fa.txt
[junit4] 2> 234770 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/contractions_it.txt
[junit4] 2> 234771 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_eu.txt
[junit4] 2> 234772 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ro.txt
[junit4] 2> 234773 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ga.txt
[junit4] 2> 234774 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stemdict_nl.txt
[junit4] 2> 234775 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_hy.txt
[junit4] 2> 234776 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/contractions_ca.txt
[junit4] 2> 234777 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stoptags_ja.txt
[junit4] 2> 234778 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_lv.txt
[junit4] 2> 234779 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/userdict_ja.txt
[junit4] 2> 234779 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_tr.txt
[junit4] 2> 234780 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_it.txt
[junit4] 2> 234781 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_ru.txt
[junit4] 2> 234782 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_th.txt
[junit4] 2> 234783 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/hyphenations_ga.txt
[junit4] 2> 234784 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_en.txt
[junit4] 2> 234785 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_hi.txt
[junit4] 2> 234786 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_pt.txt
[junit4] 2> 234787 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/lang/stopwords_id.txt
[junit4] 2> 234788 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/synonyms.txt
[junit4] 2> 234789 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/elevate.xml
[junit4] 2> 234789 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/currency.xml
[junit4] 2> 234790 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/params.json
[junit4] 2> 234791 INFO (TEST-TestSolrCLIRunExample.testInteractiveSolrCloudExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 234794 INFO (qtp372715838-2051) [n:localhost:34959_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params action=list&wt=json
[junit4] 2> 234794 INFO (qtp372715838-2051) [n:localhost:34959_solr ] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/collections params={action=list&wt=json} status=0 QTime=0
[junit4] 2> 234796 INFO (qtp372715838-2050) [n:localhost:34959_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=2&maxShardsPerNode=4&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt&action=CREATE&numShards=2&wt=json
[junit4] 2> 234797 INFO (OverseerCollectionProcessor-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.OverseerProcessor Overseer Collection Processor: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "name":"testCloudExamplePrompt",
[junit4] 2> "fromApi":"true",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"testCloudExamplePrompt",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"4",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "operation":"create"}
[junit4] 2> 234797 WARN (OverseerThreadFactory-863-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.OverseerCollectionMessageHandler OverseerCollectionProcessor.processMessage : create , {
[junit4] 2> "name":"testCloudExamplePrompt",
[junit4] 2> "fromApi":"true",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"testCloudExamplePrompt",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"4",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "operation":"create"}
[junit4] 2> 234798 WARN (OverseerThreadFactory-863-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.OverseerCollectionMessageHandler Specified replicationFactor of 2 on collection testCloudExamplePrompt is higher than or equal to the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 234798 INFO (OverseerThreadFactory-863-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.OverseerCollectionMessageHandler creating collections conf node /collections/testCloudExamplePrompt
[junit4] 2> 234798 INFO (OverseerThreadFactory-863-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.c.SolrZkClient makePath: /collections/testCloudExamplePrompt
[junit4] 2> 234800 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "name":"testCloudExamplePrompt",
[junit4] 2> "fromApi":"true",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "collection.configName":"testCloudExamplePrompt",
[junit4] 2> "numShards":"2",
[junit4] 2> "maxShardsPerNode":"4",
[junit4] 2> "stateFormat":"2",
[junit4] 2> "operation":"create"} current state version: 0
[junit4] 2> 234800 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: testCloudExamplePrompt
[junit4] 2> 234801 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/testCloudExamplePrompt/state.json
[junit4] 2> 234801 INFO (zkCallback-290-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 234801 INFO (zkCallback-296-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 234900 INFO (OverseerThreadFactory-863-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating SolrCores for new collection testCloudExamplePrompt, shardNames [shard1, shard2] , replicationFactor : 2
[junit4] 2> 234900 INFO (OverseerThreadFactory-863-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testCloudExamplePrompt_shard1_replica1 as part of shard shard1 of collection testCloudExamplePrompt on localhost:34959_solr
[junit4] 2> 234900 INFO (OverseerThreadFactory-863-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testCloudExamplePrompt_shard1_replica2 as part of shard shard1 of collection testCloudExamplePrompt on localhost:34959_solr
[junit4] 2> 234901 INFO (OverseerThreadFactory-863-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testCloudExamplePrompt_shard2_replica1 as part of shard shard2 of collection testCloudExamplePrompt on localhost:34959_solr
[junit4] 2> 234902 INFO (OverseerThreadFactory-863-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testCloudExamplePrompt_shard2_replica2 as part of shard shard2 of collection testCloudExamplePrompt on localhost:34959_solr
[junit4] 2> 234903 INFO (qtp372715838-2049) [n:localhost:34959_solr ] o.a.s.h.a.CoreAdminHandler core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt_shard1_replica2&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard1&wt=javabin&version=2
[junit4] 2> 234903 INFO (qtp372715838-2051) [n:localhost:34959_solr ] o.a.s.h.a.CoreAdminHandler core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt_shard1_replica1&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard1&wt=javabin&version=2
[junit4] 2> 234903 INFO (qtp372715838-2049) [n:localhost:34959_solr ] o.a.s.c.SolrCore Created CoreDescriptor: {name=testCloudExamplePrompt_shard1_replica2, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=testCloudExamplePrompt_shard1_replica2, collection=testCloudExamplePrompt, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/, numShards=2, dataDir=data/, shard=shard1}
[junit4] 2> 234903 INFO (qtp372715838-2051) [n:localhost:34959_solr ] o.a.s.c.SolrCore Created CoreDescriptor: {name=testCloudExamplePrompt_shard1_replica1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=testCloudExamplePrompt_shard1_replica1, collection=testCloudExamplePrompt, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/, numShards=2, dataDir=data/, shard=shard1}
[junit4] 2> 234904 INFO (qtp372715838-2087) [n:localhost:34959_solr ] o.a.s.h.a.CoreAdminHandler core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt_shard2_replica1&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard2&wt=javabin&version=2
[junit4] 2> 234904 INFO (qtp372715838-2088) [n:localhost:34959_solr ] o.a.s.h.a.CoreAdminHandler core create command qt=/admin/cores&collection.configName=testCloudExamplePrompt&name=testCloudExamplePrompt_shard2_replica2&action=CREATE&numShards=2&collection=testCloudExamplePrompt&shard=shard2&wt=javabin&version=2
[junit4] 2> 234904 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController publishing state=down
[junit4] 2> 234904 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController publishing state=down
[junit4] 2> 234904 INFO (qtp372715838-2087) [n:localhost:34959_solr ] o.a.s.c.SolrCore Created CoreDescriptor: {name=testCloudExamplePrompt_shard2_replica1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=testCloudExamplePrompt_shard2_replica1, collection=testCloudExamplePrompt, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/, numShards=2, dataDir=data/, shard=shard2}
[junit4] 2> 234904 INFO (qtp372715838-2088) [n:localhost:34959_solr ] o.a.s.c.SolrCore Created CoreDescriptor: {name=testCloudExamplePrompt_shard2_replica2, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=testCloudExamplePrompt_shard2_replica2, collection=testCloudExamplePrompt, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/, numShards=2, dataDir=data/, shard=shard2}
[junit4] 2> 234905 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController Registering watch for external collection testCloudExamplePrompt
[junit4] 2> 234905 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController publishing state=down
[junit4] 2> 234905 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"testCloudExamplePrompt_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:34959/solr",
[junit4] 2> "node_name":"localhost:34959_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"} current state version: 1
[junit4] 2> 234905 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController publishing state=down
[junit4] 2> 234905 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.c.ZkStateReader addZkWatch testCloudExamplePrompt
[junit4] 2> 234905 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController Registering watch for external collection testCloudExamplePrompt
[junit4] 2> 234906 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"testCloudExamplePrompt_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:34959/solr",
[junit4] 2> "node_name":"localhost:34959_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"}
[junit4] 2> 234906 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.c.ZkStateReader Add data for testCloudExamplePrompt ver 0
[junit4] 2> 234906 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController look for our core node name
[junit4] 2> 234906 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController Registering watch for external collection testCloudExamplePrompt
[junit4] 2> 234906 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController Registering watch for external collection testCloudExamplePrompt
[junit4] 2> 234906 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController look for our core node name
[junit4] 2> 234906 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController look for our core node name
[junit4] 2> 234907 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"testCloudExamplePrompt_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:34959/solr",
[junit4] 2> "node_name":"localhost:34959_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"} current state version: 1
[junit4] 2> 234906 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController look for our core node name
[junit4] 2> 234907 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"testCloudExamplePrompt_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:34959/solr",
[junit4] 2> "node_name":"localhost:34959_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"}
[junit4] 2> 234908 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"testCloudExamplePrompt_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:34959/solr",
[junit4] 2> "node_name":"localhost:34959_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"} current state version: 1
[junit4] 2> 234908 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"testCloudExamplePrompt_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:34959/solr",
[junit4] 2> "node_name":"localhost:34959_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"}
[junit4] 2> 234909 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = {
[junit4] 2> "core":"testCloudExamplePrompt_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:34959/solr",
[junit4] 2> "node_name":"localhost:34959_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"} current state version: 1
[junit4] 2> 234909 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={
[junit4] 2> "core":"testCloudExamplePrompt_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://localhost:34959/solr",
[junit4] 2> "node_name":"localhost:34959_solr",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"testCloudExamplePrompt",
[junit4] 2> "operation":"state"}
[junit4] 2> 235011 INFO (OverseerStateUpdate-94389258565713923-localhost:34959_solr-n_0000000000) [n:localhost:34959_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testCloudExamplePrompt/state.json version: 0
[junit4] 2> 235012 INFO (zkCallback-290-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testCloudExamplePrompt/state.json for collection testCloudExamplePrompt has occurred - updating... (live nodes size: 1)
[junit4] 2> 235013 INFO (zkCallback-290-thread-1-processing-n:localhost:34959_solr) [n:localhost:34959_solr ] o.a.s.c.c.ZkStateReader Updating data for testCloudExamplePrompt from 0 to 1
[junit4] 2> 235906 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController waiting to find shard id in clusterstate for testCloudExamplePrompt_shard1_replica1
[junit4] 2> 235906 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController Check for collection zkNode:testCloudExamplePrompt
[junit4] 2> 235907 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController waiting to find shard id in clusterstate for testCloudExamplePrompt_shard1_replica2
[junit4] 2> 235907 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController Check for collection zkNode:testCloudExamplePrompt
[junit4] 2> 235907 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController waiting to find shard id in clusterstate for testCloudExamplePrompt_shard2_replica2
[junit4] 2> 235907 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 235907 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController waiting to find shard id in clusterstate for testCloudExamplePrompt_shard2_replica1
[junit4] 2> 235907 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController Check for collection zkNode:testCloudExamplePrompt
[junit4] 2> 235907 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 235907 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController Check for collection zkNode:testCloudExamplePrompt
[junit4] 2> 235907 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.c.ZkStateReader Load collection config from:/collections/testCloudExamplePrompt
[junit4] 2> 235907 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 235907 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 235908 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.c.ZkStateReader path=/collections/testCloudExamplePrompt configName=testCloudExamplePrompt specified config exists in ZooKeeper
[junit4] 2> 235907 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/testCloudExamplePrompt
[junit4] 2> 235908 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/'
[junit4] 2> 235908 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.c.ZkStateReader Load collection config from:/collections/testCloudExamplePrompt
[junit4] 2> 235908 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.c.ZkStateReader path=/collections/testCloudExamplePrompt configName=testCloudExamplePrompt specified config exists in ZooKeeper
[junit4] 2> 235907 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/testCloudExamplePrompt
[junit4] 2> 235909 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/'
[junit4] 2> 235909 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.c.ZkStateReader path=/collections/testCloudExamplePrompt configName=testCloudExamplePrompt specified config exists in ZooKeeper
[junit4] 2> 235909 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.c.ZkStateReader path=/collections/testCloudExamplePrompt configName=testCloudExamplePrompt specified config exists in ZooKeeper
[junit4] 2> 235909 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/'
[junit4] 2> 235909 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/'
[junit4] 2> 235920 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 235924 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 235929 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 235930 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 235930 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 235930 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 235930 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig current version of requestparams : 0
[junit4] 2> 235931 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Adding specified lib dirs to ClassLoader
[junit4] 2> 235931 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 235932 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 235932 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig current version of requestparams : 0
[junit4] 2> 235932 WARN (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/extraction/lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/../../../../contrib/extraction/lib).
[junit4] 2> 235933 WARN (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/../../../../dist).
[junit4] 2> 235933 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Adding specified lib dirs to ClassLoader
[junit4] 2> 235933 WARN (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/clustering/lib/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/../../../../contrib/clustering/lib).
[junit4] 2> 235933 WARN (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/extraction/lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/../../../../contrib/extraction/lib).
[junit4] 2> 235933 WARN (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/../../../../dist).
[junit4] 2> 235934 WARN (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/../../../../dist).
[junit4] 2> 235934 WARN (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/langid/lib/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/../../../../contrib/langid/lib).
[junit4] 2> 235934 WARN (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/../../../../dist).
[junit4] 2> 235934 WARN (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/clustering/lib/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/../../../../contrib/clustering/lib).
[junit4] 2> 235934 WARN (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/velocity/lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/../../../../contrib/velocity/lib).
[junit4] 2> 235934 WARN (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/../../../../dist).
[junit4] 2> 235934 WARN (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/../../../../dist).
[junit4] 2> 235935 WARN (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/langid/lib/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/../../../../contrib/langid/lib).
[junit4] 2> 235935 WARN (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/../../../../dist).
[junit4] 2> 235936 WARN (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/velocity/lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/../../../../contrib/velocity/lib).
[junit4] 2> 235936 WARN (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica1/../../../../dist).
[junit4] 2> 235939 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 235939 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 235939 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 235939 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig current version of requestparams : 0
[junit4] 2> 235939 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 235940 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig current version of requestparams : 0
[junit4] 2> 235940 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Adding specified lib dirs to ClassLoader
[junit4] 2> 235940 WARN (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/extraction/lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/../../../../contrib/extraction/lib).
[junit4] 2> 235940 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Adding specified lib dirs to ClassLoader
[junit4] 2> 235941 WARN (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/../../../../dist).
[junit4] 2> 235941 WARN (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/extraction/lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/../../../../contrib/extraction/lib).
[junit4] 2> 235941 WARN (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/clustering/lib/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/../../../../contrib/clustering/lib).
[junit4] 2> 235941 WARN (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/../../../../dist).
[junit4] 2> 235941 WARN (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/../../../../dist).
[junit4] 2> 235942 WARN (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/clustering/lib/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/../../../../contrib/clustering/lib).
[junit4] 2> 235942 WARN (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/langid/lib/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/../../../../contrib/langid/lib).
[junit4] 2> 235942 WARN (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/../../../../dist).
[junit4] 2> 235942 WARN (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/../../../../dist).
[junit4] 2> 235942 WARN (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/langid/lib/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/../../../../contrib/langid/lib).
[junit4] 2> 235942 WARN (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/velocity/lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/../../../../contrib/velocity/lib).
[junit4] 2> 235942 WARN (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/../../../../dist).
[junit4] 2> 235943 WARN (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/../../../../dist).
[junit4] 2> 235943 WARN (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../contrib/velocity/lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/../../../../contrib/velocity/lib).
[junit4] 2> 235943 WARN (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: ../../../../dist/ (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/../../../../dist).
[junit4] 2> 235954 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
[junit4] 2> 235955 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
[junit4] 2> 235955 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
[junit4] 2> 235962 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
[junit4] 2> 235973 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 235979 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.IndexSchema Reading Solr Schema from /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 235991 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 235992 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.IndexSchema Reading Solr Schema from /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 235993 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 235993 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.IndexSchema [testCloudExamplePrompt_shard2_replica2] Schema name=example-data-driven-schema
[junit4] 2> 235993 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 236000 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.IndexSchema [testCloudExamplePrompt_shard1_replica2] Schema name=example-data-driven-schema
[junit4] 2> 236001 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.IndexSchema [testCloudExamplePrompt_shard1_replica1] Schema name=example-data-driven-schema
[junit4] 2> 236013 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 236014 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/testCloudExamplePrompt/managed-schema
[junit4] 2> 236022 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.IndexSchema [testCloudExamplePrompt_shard2_replica1] Schema name=example-data-driven-schema
[junit4] 2> 236282 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 236283 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 236304 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 236309 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 236388 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 236389 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 236389 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 236390 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 236392 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 236393 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 236393 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 236393 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 236427 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/testCloudExamplePrompt', cwd=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 236428 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.CoreContainer Creating SolrCore 'testCloudExamplePrompt_shard2_replica1' using configuration from collection testCloudExamplePrompt
[junit4] 2> 236428 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 r:core_node3 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 236428 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_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/testCloudExamplePrompt', cwd=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 236428 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 r:core_node3 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.SolrCore [[testCloudExamplePrompt_shard2_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica1/], dataDir=[null]
[junit4] 2> 236428 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.CoreContainer Creating SolrCore 'testCloudExamplePrompt_shard1_replica2' using configuration from collection testCloudExamplePrompt
[junit4] 2> 236428 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/testCloudExamplePrompt', cwd=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 236429 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 r:core_node1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 236429 INFO (qtp372715838-2087) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 r:core_node3 x:testCloudExamplePrompt_shard2_replica1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3857c19e
[junit4] 2> 236429 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.CoreContainer Creating SolrCore 'testCloudExamplePrompt_shard2_replica2' using configuration from collection testCloudExamplePrompt
[junit4] 2> 236429 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 r:core_node1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.SolrCore [[testCloudExamplePrompt_shard1_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard1_replica2/], dataDir=[null]
[junit4] 2> 236429 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 r:core_node4 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 236430 INFO (qtp372715838-2049) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 r:core_node1 x:testCloudExamplePrompt_shard1_replica2] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3857c19e
[junit4] 2> 236430 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 r:core_node4 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.SolrCore [[testCloudExamplePrompt_shard2_replica2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-002/testCloudExamplePrompt_shard2_replica2/], dataDir=[null]
[junit4] 2> 236431 INFO (qtp372715838-2088) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard2 r:core_node4 x:testCloudExamplePrompt_shard2_replica2] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3857c19e
[junit4] 2> 236436 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_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/testCloudExamplePrompt', cwd=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1
[junit4] 2> 236436 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.CoreContainer Creating SolrCore 'testCloudExamplePrompt_shard1_replica1' using configuration from collection testCloudExamplePrompt
[junit4] 2> 236436 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 r:core_node2 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 236436 INFO (qtp372715838-2051) [n:localhost:34959_solr c:testCloudExamplePrompt s:shard1 r:core_node2 x:testCloudExamplePrompt_shard1_replica1] o.a.s.c.SolrCore [[testCloudExamplePrompt_shard1_replica1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/te
[...truncated too long message...]
thread-1-processing-x:gettingstarted) [ x:gettingstarted] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 245333 INFO (searcherExecutor-909-thread-1-processing-x:gettingstarted) [ x:gettingstarted] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 245333 INFO (searcherExecutor-909-thread-1-processing-x:gettingstarted) [ x:gettingstarted] o.a.s.c.SolrCore [gettingstarted] Registered new searcher Searcher@7a60c0db[gettingstarted] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 245333 INFO (qtp287765392-2161) [ x:gettingstarted] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 245333 INFO (qtp287765392-2161) [ x:gettingstarted] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 245333 INFO (qtp287765392-2161) [ x:gettingstarted] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 245333 INFO (qtp287765392-2161) [ x:gettingstarted] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1510228148361363456
[junit4] 2> 245335 INFO (qtp287765392-2161) [ x:gettingstarted] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1510228148361363456
[junit4] 2> 245335 INFO (qtp287765392-2161) [ x:gettingstarted] o.a.s.c.CoreContainer registering core: gettingstarted
[junit4] 2> 245335 INFO (qtp287765392-2161) [ x:gettingstarted] o.a.s.s.SolrDispatchFilter [admin] webapp=null path=/admin/cores params={name=gettingstarted&action=CREATE&instanceDir=gettingstarted&wt=json} status=0 QTime=200
[junit4] 2> 245337 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@709a98f7{HTTP/1.1}{127.0.0.1:38603}
[junit4] 2> 245337 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1461724477
[junit4] 2> 245337 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.c.SolrCore [gettingstarted] CLOSING SolrCore org.apache.solr.core.SolrCore@354c63a2
[junit4] 2> 245338 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.u.UpdateHandler closing DirectUpdateHandler2{commits=0,autocommit maxTime=15000ms,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0}
[junit4] 2> 245338 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 245338 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 245338 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 245339 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.c.SolrCore [gettingstarted] Closing main searcher on request.
[junit4] 2> 245354 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 245355 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-003/schemaless/solr/gettingstarted/data/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-003/schemaless/solr/gettingstarted/data/index;done=false>>]
[junit4] 2> 245355 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-003/schemaless/solr/gettingstarted/data/index
[junit4] 2> 245355 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-003/schemaless/solr/gettingstarted/data [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-003/schemaless/solr/gettingstarted/data;done=false>>]
[junit4] 2> 245355 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001/tempDir-003/schemaless/solr/gettingstarted/data
[junit4] 2> 245356 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ x:gettingstarted] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5202fb28{/solr,null,UNAVAILABLE}
[junit4] 2> 245356 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.u.TestSolrCLIRunExample Stopped standalone Solr instance running on port 38603
[junit4] 2> 245357 INFO (TEST-TestSolrCLIRunExample.testSchemalessExample-seed#[DBF2204C7EC13CF1]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSchemalessExample
[junit4] 2> 245358 INFO (SUITE-TestSolrCLIRunExample-seed#[DBF2204C7EC13CF1]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J1/temp/solr.util.TestSolrCLIRunExample_DBF2204C7EC13CF1-001
[junit4] 2> NOTE: test params are: codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=9585, maxDocsPerChunk=764, blockSize=1014), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=9585, blockSize=1014)), sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=es_MX, timezone=Jamaica
[junit4] 2> NOTE: Linux 3.19.0-26-generic amd64/Oracle Corporation 1.8.0_60 (64-bit)/cpus=12,threads=1,free=236160432,total=533725184
[junit4] 2> NOTE: All tests run in this JVM: [FileUtilsTest, TestSuggestSpellingConverter, ZkStateWriterTest, BlockCacheTest, TestFastWriter, ExitableDirectoryReaderTest, TestOrdValues, ConnectionManagerTest, PreAnalyzedFieldTest, TestStressUserVersions, TestConfigSets, IndexSchemaRuntimeFieldTest, TestLFUCache, RollingRestartTest, CursorPagingTest, TestFuzzyAnalyzedSuggestions, SolrPluginUtilsTest, TestTrieFacet, TestSearchPerf, ResourceLoaderTest, HdfsDirectoryFactoryTest, ZkControllerTest, TestRestoreCore, SolrCmdDistributorTest, TestDistributedGrouping, FieldMutatingUpdateProcessorTest, TestMacros, JsonLoaderTest, TestReRankQParserPlugin, HdfsBasicDistributedZk2Test, ExplicitHLLTest, DeleteLastCustomShardedReplicaTest, UpdateParamsTest, RequiredFieldsTest, SharedFSAutoReplicaFailoverUtilsTest, TestAtomicUpdateErrorCases, ShardRoutingCustomTest, ClusterStateUpdateTest, TestCustomDocTransformer, BlockDirectoryTest, TestStandardQParsers, TestCursorMarkWithoutUniqueKey, TestSolrQueryParserResource, OpenCloseCoreStressTest, DistributedMLTComponentTest, AlternateDirectoryTest, ZkCLITest, TestFiltering, HighlighterMaxOffsetTest, TestBlendedInfixSuggestions, SmileWriterTest, WordBreakSolrSpellCheckerTest, RecoveryAfterSoftCommitTest, TestNoOpRegenerator, TestSolrCoreProperties, TestClassNameShortening, TestElisionMultitermQuery, DirectSolrConnectionTest, TestSolrCLIRunExample]
[junit4] Completed [111/534] on J1 in 10.85s, 3 tests, 1 error, 1 skipped <<< FAILURES!
[...truncated 1322 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:785: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:729: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:524: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1452: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1006: There were test failures: 534 suites, 2117 tests, 1 error, 67 ignored (31 assumptions)
Total time: 46 minutes 38 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
[JENKINS-EA] Lucene-Solr-5.x-Linux (32bit/jdk1.9.0-ea-b78) - Build
# 13681 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-5.x-Linux/13681/
Java: 32bit/jdk1.9.0-ea-b78 -client -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.HttpPartitionTest
Error Message:
ObjectTracker found 1 object(s) that were not released!!! [TransactionLog]
Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [TransactionLog]
at __randomizedtesting.SeedInfo.seed([48B1D5B525EEBEC8]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:236)
at sun.reflect.GeneratedMethodAccessor35.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:504)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:799)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:746)
FAILED: org.apache.solr.search.ReturnFieldsTest.testWhitespace
Error Message:
Not really whitespace? (@11): á Ž
Stack Trace:
java.lang.AssertionError: Not really whitespace? (@11): á Ž
at __randomizedtesting.SeedInfo.seed([48B1D5B525EEBEC8:8EC761FB99CCD93E]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.apache.lucene.util.TestUtil.randomWhitespace(TestUtil.java:1217)
at org.apache.solr.search.ReturnFieldsTest.testWhitespace(ReturnFieldsTest.java:348)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:504)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:746)
Build Log:
[...truncated 10514 lines...]
[junit4] Suite: org.apache.solr.search.ReturnFieldsTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001
[junit4] 2> 999195 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false)
[junit4] 2> 999195 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 999196 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 999196 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 999196 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 999219 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 999241 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
[junit4] 2> 999318 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 999319 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema12.xml
[junit4] 2> 999327 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=test
[junit4] 2> 999539 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 999540 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 999541 WARN (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 999548 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 999551 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 999553 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 999554 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrResourceLoader using system property solr.solr.home: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr
[junit4] 2> 999554 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/'
[junit4] 2> 999568 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.CoreContainer New CoreContainer 28439570
[junit4] 2> 999568 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/]
[junit4] 2> 999568 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.CoreContainer loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib
[junit4] 2> 999569 WARN (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/lib).
[junit4] 2> 999579 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 600000,connTimeout : 60000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 999584 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=true
[junit4] 2> 999588 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 999588 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 999588 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 999588 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 999589 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema12.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=collection1, collection=collection1, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/, dataDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001, shard=shard1}
[junit4] 2> 999590 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/'
[junit4] 2> 999590 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader
[junit4] 2> 999590 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.c.SolrResourceLoader Adding 'file:/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/lib/README' to classloader
[junit4] 2> 999650 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 999663 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
[junit4] 2> 999687 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 999687 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.s.IndexSchema Reading Solr Schema from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema12.xml
[junit4] 2> 999692 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 999838 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 999839 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 999839 WARN (coreLoadExecutor-2926-thread-1) [ ] o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 999844 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 999845 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 999849 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf'
[junit4] 2> 999850 INFO (coreLoadExecutor-2926-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/
[junit4] 2> 999850 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 999850 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/], dataDir=[null]
[junit4] 2> 999850 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@dca6e5
[junit4] 2> 999851 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001
[junit4] 2> 999851 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001/index/
[junit4] 2> 999851 WARN (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001/index' doesn't exist. Creating new index...
[junit4] 2> 999851 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001/index
[junit4] 2> 999852 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 999852 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1f4bc94 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@12bc31c),segFN=segments_1,generation=1}
[junit4] 2> 999852 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 999853 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [ x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001/
[junit4] 2> 999855 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 999855 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 999856 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 999856 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4] 2> 999856 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 999856 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 999856 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "uniq-fields"
[junit4] 2> 999856 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4] 2> 999856 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 999857 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 999857 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 999857 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 999858 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 999859 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 999860 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 999861 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 999864 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.PluginBag requestHandler : 'lazy' created with startup=lazy
[junit4] 2> 999866 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,spellCheckCompRH,lazy,/update/json/docs,/admin/luke,spellCheckWithWordbreak_Direct,tvrh,/get,/admin/properties,/update/json,mltrh,/admin/threads,/search-facet-def,/update/csv,/search-facet-invariants,/admin/segments,spellCheckCompRH1,/mlt,/admin/system,/replication,dismax,defaults,/config,/schema,/admin/plugins,/admin/logging,spellCheckWithWordbreak,mock,/admin/ping,/update,/admin/file,/terms,spellCheckCompRH_Direct,/debug/dump
[junit4] 2> 999866 WARN (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4] 2> 999867 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 999867 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 999867 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 999868 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=29, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=48.6298828125, floorSegmentMB=0.9052734375, forceMergeDeletesPctAllowed=7.969991077539421, segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 999868 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1f4bc94 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@12bc31c),segFN=segments_1,generation=1}
[junit4] 2> 999868 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 999868 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@6fc597[collection1] main
[junit4] 2> 999869 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO}
[junit4] 2> 999869 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using InMemoryStorage
[junit4] 2> 999869 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 999869 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 999892 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4] 2> 1000084 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1000084 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 1000085 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
[junit4] 2> 1000085 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
[junit4] 2> 1000085 INFO (coreLoadExecutor-2926-thread-1) [ x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1000085 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
[junit4] 2> 1000085 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
[junit4] 2> 1000086 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
[junit4] 2> 1000086 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
[junit4] 2> 1000086 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 1000087 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
[junit4] 2> 1000088 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
[junit4] 2> 1000088 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[1]} 0 1
[junit4] 2> 1000089 INFO (searcherExecutor-2927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6fc597[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1000090 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {add=[2]} 0 0
[junit4] 2> 1000090 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.u.UpdateHandler start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1000093 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1f4bc94 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@12bc31c),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1f4bc94 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@12bc31c),segFN=segments_2,generation=2}
[junit4] 2> 1000093 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.SolrCore newest commit generation = 2
[junit4] 2> 1000095 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.s.SolrIndexSearcher Opening Searcher@9a77fb[collection1] main
[junit4] 2> 1000095 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.u.UpdateHandler end_commit_flush
[junit4] 2> 1000097 INFO (searcherExecutor-2927-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@9a77fb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(5.4.0):c2)))}
[junit4] 2> 1000103 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.u.p.LogUpdateProcessor [collection1] webapp=null path=null params={} {commit=} 0 12
[junit4] 2> 1000106 INFO (TEST-ReturnFieldsTest.testSeparators-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSeparators
[junit4] 2> 1000106 INFO (TEST-ReturnFieldsTest.testSeparators-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSeparators
[junit4] 2> 1000117 INFO (TEST-ReturnFieldsTest.testHyphenInFieldName-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testHyphenInFieldName
[junit4] 2> 1000117 INFO (TEST-ReturnFieldsTest.testHyphenInFieldName-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testHyphenInFieldName
[junit4] 2> 1000125 INFO (TEST-ReturnFieldsTest.testManyParameters-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testManyParameters
[junit4] 2> 1000125 INFO (TEST-ReturnFieldsTest.testManyParameters-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testManyParameters
[junit4] 2> 1000127 INFO (TEST-ReturnFieldsTest.testAliases-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testAliases
[junit4] 2> 1000127 INFO (TEST-ReturnFieldsTest.testAliases-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testAliases
[junit4] 2> 1000129 INFO (TEST-ReturnFieldsTest.testTransformers-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTransformers
[junit4] 2> 1000130 INFO (TEST-ReturnFieldsTest.testTransformers-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTransformers
[junit4] 2> 1000132 INFO (TEST-ReturnFieldsTest.testTrailingDotInFieldName-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTrailingDotInFieldName
[junit4] 2> 1000132 INFO (TEST-ReturnFieldsTest.testTrailingDotInFieldName-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTrailingDotInFieldName
[junit4] 2> 1000134 INFO (TEST-ReturnFieldsTest.testWhitespace-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWhitespace
[junit4] 2> 1000134 INFO (TEST-ReturnFieldsTest.testWhitespace-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWhitespace
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ReturnFieldsTest -Dtests.method=testWhitespace -Dtests.seed=48B1D5B525EEBEC8 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=tr -Dtests.timezone=US/Alaska -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.02s J2 | ReturnFieldsTest.testWhitespace <<<
[junit4] > Throwable #1: java.lang.AssertionError: Not really whitespace? (@11): á Ž
[junit4] > at __randomizedtesting.SeedInfo.seed([48B1D5B525EEBEC8:8EC761FB99CCD93E]:0)
[junit4] > at org.apache.lucene.util.TestUtil.randomWhitespace(TestUtil.java:1217)
[junit4] > at org.apache.solr.search.ReturnFieldsTest.testWhitespace(ReturnFieldsTest.java:348)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] 2> 1000155 INFO (TEST-ReturnFieldsTest.testFunctions-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testFunctions
[junit4] 2> 1000155 INFO (TEST-ReturnFieldsTest.testFunctions-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testFunctions
[junit4] 2> 1000157 INFO (TEST-ReturnFieldsTest.testCopyRename-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCopyRename
[junit4] 2> 1000158 INFO (TEST-ReturnFieldsTest.testCopyRename-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=id&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 1000160 INFO (TEST-ReturnFieldsTest.testCopyRename-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=xxx:id&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 1000161 INFO (TEST-ReturnFieldsTest.testCopyRename-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=id,xxx:id&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 1000161 INFO (TEST-ReturnFieldsTest.testCopyRename-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=xxx:id,id&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 1000162 INFO (TEST-ReturnFieldsTest.testCopyRename-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=xxx:id,yyy:id&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 1000163 INFO (TEST-ReturnFieldsTest.testCopyRename-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCopyRename
[junit4] 2> 1000165 INFO (TEST-ReturnFieldsTest.testFunkyFieldNames-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testFunkyFieldNames
[junit4] 2> 1000166 INFO (TEST-ReturnFieldsTest.testFunkyFieldNames-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={q=id:1&fl=#foo_s&fl=id&wt=xml} hits=1 status=0 QTime=0
[junit4] 2> 1000166 INFO (TEST-ReturnFieldsTest.testFunkyFieldNames-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testFunkyFieldNames
[junit4] 2> 1000173 INFO (TEST-ReturnFieldsTest.testTrailingDollarInFieldName-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTrailingDollarInFieldName
[junit4] 2> 1000174 INFO (TEST-ReturnFieldsTest.testTrailingDollarInFieldName-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTrailingDollarInFieldName
[junit4] 2> 1000175 INFO (TEST-ReturnFieldsTest.testWilcards-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWilcards
[junit4] 2> 1000176 INFO (TEST-ReturnFieldsTest.testWilcards-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWilcards
[junit4] 2> 1000176 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 1000176 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=28439570
[junit4] 2> 1000176 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@549242
[junit4] 2> 1000177 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.u.UpdateHandler closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 1000177 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 1000177 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 1000177 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 1000179 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 1000196 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 1000196 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001/index [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001/index;done=false>>]
[junit4] 2> 1000196 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001/index
[junit4] 2> 1000196 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory looking to close /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001 [CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001;done=false>>]
[junit4] 2> 1000197 INFO (SUITE-ReturnFieldsTest-seed#[48B1D5B525EEBEC8]-worker) [ x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001/init-core-data-001
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J2/temp/solr.search.ReturnFieldsTest_48B1D5B525EEBEC8-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {text_np=PostingsFormat(name=MockRandom), id=PostingsFormat(name=LuceneFixedGap), text=PostingsFormat(name=Asserting), #foo_s=PostingsFormat(name=LuceneFixedGap)}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=tr, timezone=US/Alaska
[junit4] 2> NOTE: Linux 3.19.0-26-generic i386/Oracle Corporation 1.9.0-ea (32-bit)/cpus=12,threads=1,free=169107168,total=369229824
[junit4] 2> NOTE: All tests run in this JVM: [RegexBoostProcessorTest, ResponseLogComponentTest, TestStressRecovery, TestSort, TestGroupingSearch, AddSchemaFieldsUpdateProcessorFactoryTest, StressHdfsTest, HdfsDirectoryTest, AsyncCallRequestStatusResponseTest, TestRandomRequestDistribution, TestZkChroot, BJQParserTest, TestEmbeddedSolrServerConstructors, TestBulkSchemaAPI, NumericFieldsTest, TestConfigOverlay, DistributedQueueTest, DistributedQueryComponentOptimizationTest, PrimUtilsTest, XsltUpdateRequestHandlerTest, TestReplicaProperties, OverseerTest, HdfsChaosMonkeySafeLeaderTest, TestQueryTypes, QueryEqualityTest, ZkStateReaderTest, RuleEngineTest, TestUtils, DOMUtilTest, SSLMigrationTest, TestRemoveLastDynamicCopyField, TestInitParams, LeaderElectionTest, SOLR749Test, TestRuleBasedAuthorizationPlugin, DistribCursorPagingTest, CircularListTest, FacetPivotSmallTest, TermVectorComponentDistributedTest, TestExceedMaxTermLength, CachingDirectoryFactoryTest, RecoveryZkTest, HdfsNNFailoverTest, TestFieldCollectionResource, CloudMLTQParserTest, DirectUpdateHandlerTest, HdfsWriteToMultipleCollectionsTest, TriLevelCompositeIdRoutingTest, TestCollationField, TestCollectionAPI, SolrInfoMBeanTest, TestFastOutputStream, BufferStoreTest, TestFieldTypeResource, CollectionStateFormat2Test, SimpleFacetsTest, HdfsRecoveryZkTest, TestReqParamsAPI, HdfsUnloadDistributedZkTest, TestQueryUtils, TestTolerantSearch, BigEndianAscendingWordSerializerTest, OutputWriterTest, PathHierarchyTokenizerFactoryTest, TestSchemaVersionResource, OutOfBoxZkACLAndCredentialsProvidersTest, CoreAdminRequestStatusTest, TestSolrJ, XmlUpdateRequestHandlerTest, TestFieldSortValues, SolrCoreCheckLockOnStartupTest, OpenExchangeRatesOrgProviderTest, DocValuesTest, TestJsonFacets, TestManagedSchemaFieldResource, DeleteInactiveReplicaTest, TestRecovery, CloudExitableDirectoryReaderTest, SuggesterTest, DistributedFacetPivotSmallTest, DistributedQueryElevationComponentTest, TestQuerySenderNoQuery, TestSortingResponseWriter, BadIndexSchemaTest, SuggestComponentTest, StatsComponentTest, CollectionsAPIDistributedZkTest, ClusterStateUpdateTest, ZkCLITest, ShardRoutingCustomTest, TestDistributedSearch, CurrencyFieldOpenExchangeTest, AnalysisAfterCoreReloadTest, SpellCheckCollatorTest, SuggesterTSTTest, SuggesterWFSTTest, SortByFunctionTest, TestSolrDeletionPolicy1, IndexBasedSpellCheckerTest, TestOmitPositions, TestIndexingPerformance, TestSolrQueryParser, ReturnFieldsTest]
[junit4] Completed [343/534] on J2 in 1.03s, 12 tests, 1 failure <<< FAILURES!
[...truncated 209 lines...]
[junit4] Suite: org.apache.solr.cloud.HttpPartitionTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/init-core-data-001
[junit4] 2> 1100524 INFO (SUITE-HttpPartitionTest-seed#[48B1D5B525EEBEC8]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 1100525 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1100526 INFO (Thread-4542) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1100526 INFO (Thread-4542) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1100626 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.ZkTestServer start zk server on port:55307
[junit4] 2> 1100626 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1100627 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1100628 INFO (zkCallback-974-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1689bb5 name:ZooKeeperConnection Watcher:127.0.0.1:55307 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1100628 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1100629 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1100629 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1100630 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1100631 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1100631 INFO (zkCallback-975-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@16932fc name:ZooKeeperConnection Watcher:127.0.0.1:55307/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1100631 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1100632 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1100632 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 1100632 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 1100633 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 1100634 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 1100635 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 1100635 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 1100636 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 1100637 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 1100637 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1100638 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1100639 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 1100639 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 1100640 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 1100640 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 1100641 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 1100641 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 1100642 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 1100642 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 1100643 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1100643 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 1100644 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1100644 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1100645 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 1100645 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 1100646 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.AbstractZkTestCase put /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 1100646 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 1100701 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1
[junit4] 2> 1100702 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 1100703 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@acc0dd{/,null,AVAILABLE}
[junit4] 2> 1100704 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.e.j.s.ServerConnector Started ServerConnector@154805{HTTP/1.1}{127.0.0.1:33835}
[junit4] 2> 1100704 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.e.j.s.Server Started @1102378ms
[junit4] 2> 1100704 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/tempDir-001/control/data, hostContext=/, hostPort=40323, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores}
[junit4] 2> 1100705 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@530c12
[junit4] 2> 1100705 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/'
[junit4] 2> 1100717 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1100717 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1100719 INFO (zkCallback-976-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@ef51dd name:ZooKeeperConnection Watcher:127.0.0.1:55307/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1100719 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1100719 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1100720 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 1100720 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/solr.xml
[junit4] 2> 1100724 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.CoresLocator Config-defined core root directory: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores
[junit4] 2> 1100724 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.CoreContainer New CoreContainer 31719371
[junit4] 2> 1100724 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/]
[junit4] 2> 1100724 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.CoreContainer loading shared library: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/lib
[junit4] 2> 1100724 WARN (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to classloader: lib (resolved as: /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/lib).
[junit4] 2> 1100729 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 1100730 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1100731 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1100731 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1100731 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:55307/solr
[junit4] 2> 1100731 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 1100731 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1100732 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1100733 INFO (zkCallback-978-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@e329a7 name:ZooKeeperConnection Watcher:127.0.0.1:55307 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1100733 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1100733 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1100734 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1100735 INFO (zkCallback-979-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@98fef2 name:ZooKeeperConnection Watcher:127.0.0.1:55307/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1100735 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1100736 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1100737 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work
[junit4] 2> 1100738 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running
[junit4] 2> 1100739 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed
[junit4] 2> 1100740 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure
[junit4] 2> 1100740 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1100741 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1100742 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1100742 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1100743 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:40323_
[junit4] 2> 1100743 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:40323_
[junit4] 2> 1100744 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1100744 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election
[junit4] 2> 1100745 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1100745 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/94389737705504772-127.0.0.1:40323_-n_0000000000
[junit4] 2> 1100745 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:40323_
[junit4] 2> 1100746 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader
[junit4] 2> 1100746 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.Overseer Overseer (id=94389737705504772-127.0.0.1:40323_-n_0000000000) starting
[junit4] 2> 1100747 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1100749 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1100750 INFO (OverseerCollectionProcessor-94389737705504772-127.0.0.1:40323_-n_0000000000) [n:127.0.0.1:40323_ ] o.a.s.c.OverseerProcessor Process current queue of overseer operations
[junit4] 2> 1100750 INFO (OverseerStateUpdate-94389737705504772-127.0.0.1:40323_-n_0000000000) [n:127.0.0.1:40323_ ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1100750 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 1100793 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module.
[junit4] 2> 1100793 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1100794 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.CoresLocator Looking for core definitions underneath /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores
[junit4] 2> 1100794 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.SolrCore Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, instanceDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1, collection=control_collection, absoluteInstDir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 1100795 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.CoresLocator Found core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/
[junit4] 2> 1100795 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 1100795 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.ZkController publishing state=down
[junit4] 2> 1100796 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property
[junit4] 2> 1100795 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.s.SolrDispatchFilter user.dir=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 1100796 INFO (TEST-HttpPartitionTest.test-seed#[48B1D5B525EEBEC8]) [n:127.0.0.1:40323_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done
[junit4] 2> 1100796 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.ZkController look for our core node name
[junit4] 2> 1100796 INFO (OverseerStateUpdate-94389737705504772-127.0.0.1:40323_-n_0000000000) [n:127.0.0.1:40323_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:40323",
[junit4] 2> "node_name":"127.0.0.1:40323_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1100797 INFO (OverseerStateUpdate-94389737705504772-127.0.0.1:40323_-n_0000000000) [n:127.0.0.1:40323_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:40323",
[junit4] 2> "node_name":"127.0.0.1:40323_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1100797 INFO (OverseerStateUpdate-94389737705504772-127.0.0.1:40323_-n_0000000000) [n:127.0.0.1:40323_ ] o.a.s.c.o.ClusterStateMutator building a new cName: control_collection
[junit4] 2> 1100797 INFO (OverseerStateUpdate-94389737705504772-127.0.0.1:40323_-n_0000000000) [n:127.0.0.1:40323_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1
[junit4] 2> 1100798 INFO (zkCallback-979-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ ] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4] 2> 1101796 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 1101797 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:control_collection
[junit4] 2> 1101797 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 1101797 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection
[junit4] 2> 1101797 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1101798 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/'
[junit4] 2> 1101808 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 1101812 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 1101817 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 5.4.0
[junit4] 2> 1101827 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.Config Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1101828 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 1101832 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1101915 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 1101919 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 1101920 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 1101925 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1101926 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1101928 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1101928 WARN (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1101929 WARN (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1101929 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 1101929 WARN (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 1101929 WARN (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 1101931 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] 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-5.x-Linux/solr/build/solr-core/test/J0
[junit4] 2> 1101931 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection control_collection
[junit4] 2> 1101931 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1101931 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/], dataDir=[null]
[junit4] 2> 1101931 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@1a00437
[junit4] 2> 1101932 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/data
[junit4] 2> 1101932 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/data/index/
[junit4] 2> 1101932 WARN (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/data/index' doesn't exist. Creating new index...
[junit4] 2> 1101932 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/data/index
[junit4] 2> 1101933 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=60.7412109375, floorSegmentMB=1.947265625, forceMergeDeletesPctAllowed=19.537433919334102, segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1101933 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1dfe56e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48f11f),segFN=segments_1,generation=1}
[junit4] 2> 1101933 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1101934 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/data/
[junit4] 2> 1101934 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_48B1D5B525EEBEC8-001/control-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories.
[junit4] 2> 1101936 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "nodistrib"
[junit4] 2> 1101937 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "dedupe"
[junit4] 2> 1101937 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 1101937 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "stored_sig"
[junit4] 2> 1101937 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 1101937 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 1101938 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1101938 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 1101938 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 1101939 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1101940 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1101940 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1101941 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1101943 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 1101944 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1101944 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1101944 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1101945 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 1101945 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 1101945 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=24, maxMergeAtOnceExplicit=37, maxMergedSegmentMB=2.328125, floorSegmentMB=1.3779296875, forceMergeDeletesPctAllowed=20.165438258432317, segmentsPerTier=25.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 1101946 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@1dfe56e lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@48f11f),segFN=segments_1,generation=1}
[junit4] 2> 1101946 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 1101946 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@f94036[collection1] main
[junit4] 2> 1101946 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:/collections/control_collection
[junit4] 2> 1101947 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 1101947 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 1101947 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 1101947 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 1101947 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1101948 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode /configs/conf1/_rest_managed.json
[junit4] 2> 1101948 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1101948 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1101948 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1101949 INFO (searcherExecutor-5241-thread-1-processing-n:127.0.0.1:40323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@f94036[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1101949 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 1101949 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index
[junit4] 2> 1101949 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index
[junit4] 2> 1101949 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1510235804779151360
[junit4] 2> 1101951 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with highest version 1510235804779151360
[junit4] 2> 1101951 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 1101951 INFO (coreLoadExecutor-5240-thread-1-processing-n:127.0.0.1:40323_) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1101951 INFO (coreZkRegister-5234-thread-1-processing-n:127.0.0.1:40323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:http://127.0.0.1:40323 collection:control_collection shard:shard1
[junit4] 2> 1101952 INFO (coreZkRegister-5234-thread-1-processing-n:127.0.0.1:40323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leader_elect/shard1/election
[junit4] 2> 1101953 INFO (coreZkRegister-5234-thread-1-processing-n:127.0.0.1:40323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector Joined leadership election with path: /collections/control_collection/leader_elect/shard1/election/94389737705504772-core_node1-n_0000000000
[junit4] 2> 1101954 INFO (coreZkRegister-5234-thread-1-processing-n:127.0.0.1:40323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1
[junit4] 2> 1101955 INFO (coreZkRegister-5234-thread-1-processing-n:127.0.0.1:40323_ x:collection1 s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:40323_ c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 110
[...truncated too long message...]
UpdateRequestCodec.java:121)
[junit4] 2> at org.apache.solr.common.util.JavaBinCodec.readVal(JavaBinCodec.java:214)
[junit4] 2> at org.apache.solr.common.util.JavaBinCodec.unmarshal(JavaBinCodec.java:134)
[junit4] 2> at org.apache.solr.client.solrj.request.JavaBinUpdateRequestCodec.unmarshal(JavaBinUpdateRequestCodec.java:186)
[junit4] 2> at org.apache.solr.handler.loader.JavabinLoader.parseAndLoadDocs(JavabinLoader.java:111)
[junit4] 2> at org.apache.solr.handler.loader.JavabinLoader.load(JavabinLoader.java:58)
[junit4] 2> at org.apache.solr.handler.UpdateRequestHandler$1.load(UpdateRequestHandler.java:98)
[junit4] 2> at org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:74)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:151)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2079)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:667)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:460)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:210)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:179)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:106)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.eclipse.jetty.servlets.UserAgentFilter.doFilter(UserAgentFilter.java:83)
[junit4] 2> at org.eclipse.jetty.servlets.GzipFilter.doFilter(GzipFilter.java:300)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1652)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:585)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:499)
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:310)
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:540)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
[junit4] 2> at java.lang.Thread.run(Thread.java:746)
[junit4] 2>
[junit4] 2> Aug 22, 2015 7:53:48 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {range_facet_l_dv=PostingsFormat(name=Asserting), _version_=PostingsFormat(name=MockRandom), multiDefault=PostingsFormat(name=LuceneFixedGap), a_t=PostingsFormat(name=MockRandom), intDefault=PostingsFormat(name=MockRandom), id=PostingsFormat(name=Asserting), range_facet_i_dv=PostingsFormat(name=MockRandom), text=PostingsFormat(name=LuceneVarGapFixedInterval), range_facet_l=PostingsFormat(name=MockRandom), timestamp=PostingsFormat(name=MockRandom)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene50), range_facet_i_dv=DocValuesFormat(name=Lucene50), timestamp=DocValuesFormat(name=Lucene50)}, sim=DefaultSimilarity, locale=lt, timezone=SystemV/EST5EDT
[junit4] 2> NOTE: Linux 3.19.0-26-generic i386/Oracle Corporation 1.9.0-ea (32-bit)/cpus=12,threads=1,free=92566920,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [BitVectorTest, RequestHandlersTest, TestRandomFaceting, TestReplicationHandler, MinimalSchemaTest, DistributedExpandComponentTest, URLClassifyProcessorTest, TestFreeTextSuggestions, UniqFieldsUpdateProcessorFactoryTest, SimpleCollectionCreateDeleteTest, CustomCollectionTest, TestReloadDeadlock, TestWordDelimiterFilterFactory, MultiTermTest, SegmentsInfoRequestHandlerTest, ParsingFieldUpdateProcessorsTest, DistribJoinFromCollectionTest, MBeansHandlerTest, StandardRequestHandlerTest, ChangedSchemaMergeTest, TestShardHandlerFactory, TestDynamicFieldCollectionResource, CollectionTooManyReplicasTest, DistributedDebugComponentTest, AssignTest, TestJmxMonitoredMap, TestPostingsSolrHighlighter, TestDFRSimilarityFactory, JavabinLoaderTest, TestArbitraryIndexDir, HdfsThreadLeakTest, SpatialHeatmapFacetsTest, TestDefaultStatsCache, SimplePostToolTest, TestMiniSolrCloudCluster, CurrencyFieldXmlFileTest, SolrCoreTest, TestRequestStatusCollectionAPI, FastVectorHighlighterTest, TestUpdate, PKIAuthenticationIntegrationTest, TestFunctionQuery, DistributedSuggestComponentTest, TestSolr4Spatial, TermsComponentTest, PeerSyncTest, DateFieldTest, LeaderElectionIntegrationTest, SaslZkACLProviderTest, DistribDocExpirationUpdateProcessorTest, AnalysisErrorHandlingTest, TestSchemaNameResource, TestCodecSupport, TestExpandComponent, DataDrivenBlockJoinTest, TestJmxIntegration, SolrIndexConfigTest, CleanupOldIndexTest, VersionInfoTest, SignatureUpdateProcessorFactoryTest, SpatialRPTFieldTypeTest, TestDocBasedVersionConstraints, TermVectorComponentTest, TestCloudSchemaless, TimeZoneUtilsTest, SchemaVersionSpecificBehaviorTest, TestSchemaResource, TestHighlightDedupGrouping, TestRandomDVFaceting, TestExactStatsCache, QueryResultKeyTest, TestDynamicFieldResource, TestCloudPivotFacet, CSVRequestHandlerTest, HighlighterConfigTest, TestTrackingShardHandlerFactory, DefaultValueUpdateProcessorTest, LeaderInitiatedRecoveryOnCommitTest, TestRawResponseWriter, TestCloudInspectUtil, TestSolrConfigHandler, TestSweetSpotSimilarityFactory, TestSimpleTrackingShardHandler, TestSolrIndexConfig, DistanceUnitsTest, DistributedQueryComponentCustomSortTest, DateMathParserTest, TestJoin, TestCoreContainer, SolrCmdDistributorTest, ConvertedLegacyTest, BasicFunctionalityTest, TestLazyCores, TestBadConfig, OverseerCollectionProcessorTest, TestIndexSearcher, HighlighterTest, SoftAutoCommitTest, TestExtendedDismaxParser, CoreAdminHandlerTest, SolrRequestParserTest, TestTrie, TestCSVLoader, DirectUpdateHandlerOptimizeTest, TestRemoteStreaming, DebugComponentTest, TestSurroundQueryParser, TestReversedWildcardFilterFactory, PrimitiveFieldTypeTest, DocumentBuilderTest, TestValueSourceCache, FieldAnalysisRequestHandlerTest, IndexSchemaTest, JSONWriterTest, QueryParsingTest, BinaryUpdateRequestHandlerTest, TestPHPSerializedResponseWriter, TestBinaryResponseWriter, UpdateParamsTest, TestMergePolicyConfig, SampleTest, TestBinaryField, TestFuzzyAnalyzedSuggestions, DirectSolrConnectionTest, TestLuceneMatchVersion, SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest, TestLMDirichletSimilarityFactory, TestIBSimilarityFactory, TestDefaultSimilarityFactory, PluginInfoTest, TestSystemIdResolver, SpellingQueryConverterTest, ClusterStateTest, TestLRUCache, TestDocumentBuilder, ZkNodePropsTest, SliceStateTest, UUIDFieldTest, FileUtilsTest, SolrTestCaseJ4Test, TestCrossCoreJoin, ActionThrottleTest, AsyncMigrateRouteKeyTest, ConcurrentDeleteAndCreateCollectionTest, DeleteReplicaTest, HttpPartitionTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HttpPartitionTest -Dtests.seed=48B1D5B525EEBEC8 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=lt -Dtests.timezone=SystemV/EST5EDT -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.00s J0 | HttpPartitionTest (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ObjectTracker found 1 object(s) that were not released!!! [TransactionLog]
[junit4] > at __randomizedtesting.SeedInfo.seed([48B1D5B525EEBEC8]:0)
[junit4] > at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:236)
[junit4] > at java.lang.Thread.run(Thread.java:746)
[junit4] Completed [411/534] on J0 in 131.96s, 1 test, 1 failure <<< FAILURES!
[...truncated 400 lines...]
BUILD FAILED
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:785: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:729: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/build.xml:59: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/build.xml:233: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/solr/common-build.xml:524: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1452: The following error occurred while executing this line:
/home/jenkins/workspace/Lucene-Solr-5.x-Linux/lucene/common-build.xml:1006: There were test failures: 534 suites, 2117 tests, 1 suite-level error, 1 failure, 67 ignored (31 assumptions)
Total time: 53 minutes 54 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any