lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@sd-datasolutions.de>
Subject [JENKINS] Lucene-Solr-trunk-Linux (32bit/jdk1.6.0_35) - Build # 2136 - Still Failing!
Date Thu, 01 Nov 2012 19:00:40 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-trunk-Linux/2136/
Java: 32bit/jdk1.6.0_35 -server -XX:+UseSerialGC

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

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

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


REGRESSION:  org.apache.solr.cloud.LeaderElectionIntegrationTest.testSimpleSliceLeaderElection

Error Message:
Test abandoned because suite timeout was reached.

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




Build Log:
[...truncated 8388 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.LeaderElectionIntegrationTest
[junit4:junit4]   2> 9 T42 oas.SolrTestCaseJ4.setUp ###Starting testLeaderElectionAfterClientTimeout
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153
[junit4:junit4]   2> 34 T42 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 146 T43 oaz.Environment.logEnv Server environment:zookeeper.version=3.3.6-1366786, built on 07/29/2012 06:22 GMT
[junit4:junit4]   2> 147 T43 oaz.Environment.logEnv Server environment:host.name=serv1
[junit4:junit4]   2> 147 T43 oaz.Environment.logEnv Server environment:java.version=1.6.0_35
[junit4:junit4]   2> 147 T43 oaz.Environment.logEnv Server environment:java.vendor=Sun Microsystems Inc.
[junit4:junit4]   2> 147 T43 oaz.Environment.logEnv Server environment:java.home=/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/jre
[junit4:junit4]   2> 147 T43 oaz.Environment.logEnv Server environment:java.class.path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/classes/test:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-test-framework/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/test-framework/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/codecs/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/analysis/common/lucene-analyzers-common-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/analysis/kuromoji/lucene-analyzers-kuromoji-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/analysis/phonetic/lucene-analyzers-phonetic-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/highlighter/lucene-highlighter-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/memory/lucene-memory-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/misc/lucene-misc-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/spatial/lucene-spatial-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/suggest/lucene-suggest-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/grouping/lucene-grouping-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/queries/lucene-queries-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/queryparser/lucene-queryparser-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/commons-cli-1.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/commons-codec-1.7.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/commons-fileupload-1.2.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/commons-lang-2.6.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/easymock-2.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/guava-r05.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/javax.servlet-api-3.0.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/metrics-core-2.1.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/spatial4j-0.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/commons-io-2.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/httpclient-4.1.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/httpcore-4.1.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/httpmime-4.1.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/jcl-over-slf4j-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/log4j-over-slf4j-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/slf4j-api-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/slf4j-jdk14-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/wstx-asl-3.2.7.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/zookeeper-3.3.6.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-continuation-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-deploy-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-http-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-io-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-jmx-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-security-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-server-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-servlet-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-util-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-webapp-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-xml-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/servlet-api-3.0.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/example-DIH/solr/db/lib/hsqldb-1.8.0.10.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/core/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/test-framework/lib/junit-4.10.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/test-framework/lib/randomizedtesting-runner-2.0.4.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-launcher.jar:/var/lib/jenkins/.ant/lib/ivy-2.2.0.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-jdepend.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-netrexx.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-antlr.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-commons-net.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-javamail.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-regexp.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-jsch.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-xalan2.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-junit4.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-jmf.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-junit.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-bcel.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-jai.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-commons-logging.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-resolver.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-oro.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-swing.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-bsf.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-log4j.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-testutil.jar:/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/lib/tools.jar:/var/lib/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.0.4.jar
[junit4:junit4]   2> 154 T43 oaz.Environment.logEnv Server environment:java.library.path=/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/jre/lib/i386/server:/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/jre/lib/i386:/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/jre/../lib/i386:/usr/lib/jvm/j2sdk1.6-sun/jre/lib/amd64/server:/usr/lib/jvm/j2sdk1.6-sun/jre/lib/amd64:/usr/lib/jvm/j2sdk1.6-sun/jre/../lib/amd64:/usr/java/packages/lib/i386:/lib:/usr/lib
[junit4:junit4]   2> 154 T43 oaz.Environment.logEnv Server environment:java.io.tmpdir=.
[junit4:junit4]   2> 155 T43 oaz.Environment.logEnv Server environment:java.compiler=<NA>
[junit4:junit4]   2> 155 T43 oaz.Environment.logEnv Server environment:os.name=Linux
[junit4:junit4]   2> 155 T43 oaz.Environment.logEnv Server environment:os.arch=i386
[junit4:junit4]   2> 155 T43 oaz.Environment.logEnv Server environment:os.version=3.2.0-32-generic
[junit4:junit4]   2> 155 T43 oaz.Environment.logEnv Server environment:user.name=jenkins
[junit4:junit4]   2> 156 T43 oaz.Environment.logEnv Server environment:user.home=/var/lib/jenkins
[junit4:junit4]   2> 156 T43 oaz.Environment.logEnv Server environment:user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 173 T43 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 206 T43 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 236 T43 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 262 T42 oasc.ZkTestServer.run start zk server on port:47385
[junit4:junit4]   2> 304 T42 oaz.Environment.logEnv Client environment:zookeeper.version=3.3.6-1366786, built on 07/29/2012 06:22 GMT
[junit4:junit4]   2> 305 T42 oaz.Environment.logEnv Client environment:host.name=serv1
[junit4:junit4]   2> 305 T42 oaz.Environment.logEnv Client environment:java.version=1.6.0_35
[junit4:junit4]   2> 306 T42 oaz.Environment.logEnv Client environment:java.vendor=Sun Microsystems Inc.
[junit4:junit4]   2> 306 T42 oaz.Environment.logEnv Client environment:java.home=/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/jre
[junit4:junit4]   2> 306 T42 oaz.Environment.logEnv Client environment:java.class.path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/classes/test:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-test-framework/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/test-framework/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/codecs/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/analysis/common/lucene-analyzers-common-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/analysis/kuromoji/lucene-analyzers-kuromoji-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/analysis/phonetic/lucene-analyzers-phonetic-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/highlighter/lucene-highlighter-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/memory/lucene-memory-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/misc/lucene-misc-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/spatial/lucene-spatial-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/suggest/lucene-suggest-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/grouping/lucene-grouping-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/queries/lucene-queries-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/queryparser/lucene-queryparser-5.0-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/commons-cli-1.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/commons-codec-1.7.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/commons-fileupload-1.2.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/commons-lang-2.6.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/easymock-2.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/guava-r05.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/javax.servlet-api-3.0.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/metrics-core-2.1.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/core/lib/spatial4j-0.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/commons-io-2.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/httpclient-4.1.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/httpcore-4.1.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/httpmime-4.1.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/jcl-over-slf4j-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/log4j-over-slf4j-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/slf4j-api-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/slf4j-jdk14-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/wstx-asl-3.2.7.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/solrj/lib/zookeeper-3.3.6.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-continuation-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-deploy-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-http-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-io-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-jmx-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-security-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-server-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-servlet-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-util-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-webapp-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/jetty-xml-8.1.2.v20120308.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/lib/servlet-api-3.0.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/example-DIH/solr/db/lib/hsqldb-1.8.0.10.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/build/core/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/test-framework/lib/junit-4.10.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/test-framework/lib/randomizedtesting-runner-2.0.4.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-launcher.jar:/var/lib/jenkins/.ant/lib/ivy-2.2.0.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-jdepend.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-netrexx.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-antlr.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-commons-net.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-javamail.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-regexp.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-jsch.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-xalan2.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-junit4.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-jmf.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-junit.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-bcel.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-jai.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-commons-logging.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-resolver.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-oro.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-swing.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-bsf.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-apache-log4j.jar:/var/lib/jenkins/tools/Ant/ANT_1.8.2/lib/ant-testutil.jar:/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/lib/tools.jar:/var/lib/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.0.4.jar
[junit4:junit4]   2> 308 T42 oaz.Environment.logEnv Client environment:java.library.path=/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/jre/lib/i386/server:/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/jre/lib/i386:/mnt/ssd/jenkins/tools/java/32bit/jdk1.6.0_35/jre/../lib/i386:/usr/lib/jvm/j2sdk1.6-sun/jre/lib/amd64/server:/usr/lib/jvm/j2sdk1.6-sun/jre/lib/amd64:/usr/lib/jvm/j2sdk1.6-sun/jre/../lib/amd64:/usr/java/packages/lib/i386:/lib:/usr/lib
[junit4:junit4]   2> 308 T42 oaz.Environment.logEnv Client environment:java.io.tmpdir=.
[junit4:junit4]   2> 309 T42 oaz.Environment.logEnv Client environment:java.compiler=<NA>
[junit4:junit4]   2> 309 T42 oaz.Environment.logEnv Client environment:os.name=Linux
[junit4:junit4]   2> 309 T42 oaz.Environment.logEnv Client environment:os.arch=i386
[junit4:junit4]   2> 310 T42 oaz.Environment.logEnv Client environment:os.version=3.2.0-32-generic
[junit4:junit4]   2> 310 T42 oaz.Environment.logEnv Client environment:user.name=jenkins
[junit4:junit4]   2> 310 T42 oaz.Environment.logEnv Client environment:user.home=/var/lib/jenkins
[junit4:junit4]   2> 311 T42 oaz.Environment.logEnv Client environment:user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0
[junit4:junit4]   2> 314 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@13a0067
[junit4:junit4]   2> 346 T48 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 348 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 349 T48 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 372 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35643
[junit4:junit4]   2> 378 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35643
[junit4:junit4]   2> 385 T46 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 451 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20000 with negotiated timeout 10000 for client /127.0.0.1:35643
[junit4:junit4]   2> 451 T48 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20000, negotiated timeout = 10000
[junit4:junit4]   2> 455 T49 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@13a0067 name:ZooKeeperConnection Watcher:127.0.0.1:47385 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 456 T42 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 465 T42 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 498 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20000
[junit4:junit4]   2> 499 T42 oaz.ZooKeeper.close Session: 0x13abce790a20000 closed
[junit4:junit4]   2> 499 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1a5e4e4
[junit4:junit4]   2> 500 T44 oazs.NIOServerCnxn.doIO WARNING EndOfStreamException: Unable to read additional data from client sessionid 0x13abce790a20000, likely client has closed socket
[junit4:junit4]   2> 500 T49 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 500 T50 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 501 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 502 T50 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 503 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35643 which had sessionid 0x13abce790a20000
[junit4:junit4]   2> 504 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35644
[junit4:junit4]   2> 504 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35644
[junit4:junit4]   2> 505 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20001 with negotiated timeout 10000 for client /127.0.0.1:35644
[junit4:junit4]   2> 510 T50 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20001, negotiated timeout = 10000
[junit4:junit4]   2> 518 T51 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1a5e4e4 name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 520 T42 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 525 T42 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4]   2> 570 T42 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 581 T42 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4]   2> 590 T42 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4]   2> 593 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 608 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 623 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4]   2> 625 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4]   2> 637 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 639 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4]   2> 649 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4]   2> 650 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4]   2> 655 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4]   2> 655 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4]   2> 663 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4]   2> 664 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4]   2> 670 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 671 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4]   2> 675 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 675 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4]   2> 687 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 688 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4]   2> 694 T42 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4]   2> 695 T42 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4]   2> 705 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20001
[junit4:junit4]   2> 705 T51 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 706 T42 oaz.ZooKeeper.close Session: 0x13abce790a20001 closed
[junit4:junit4]   2> 706 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35644 which had sessionid 0x13abce790a20001
[junit4:junit4]   2> 706 T42 oasc.LeaderElectionIntegrationTest.setUp ####SETUP_START testLeaderElectionAfterClientTimeout
[junit4:junit4]   2> 707 T42 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 708 T42 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 708 T42 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 708 T42 oasc.CoreContainer.<init> New CoreContainer 32087476
[junit4:junit4]   2> 709 T42 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 709 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 755 T42 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 770 T42 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47385/solr
[junit4:junit4]   2> 778 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@167198e
[junit4:junit4]   2> 779 T52 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 779 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 780 T52 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 780 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35645
[junit4:junit4]   2> 780 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35645
[junit4:junit4]   2> 781 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20002 with negotiated timeout 3000 for client /127.0.0.1:35645
[junit4:junit4]   2> 782 T52 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20002, negotiated timeout = 3000
[junit4:junit4]   2> 782 T53 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@167198e name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 782 T42 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 789 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 793 T42 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4]   2> 796 T42 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 799 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:delete cxid:0x7 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7000_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 803 T42 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 816 T42 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 817 T42 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 817 T42 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 818 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 818 T42 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 818 T42 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 819 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 819 T42 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 819 T42 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 820 T42 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 825 T42 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4]   2> 834 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:delete cxid:0x15 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 835 T42 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 846 T42 oasc.Overseer.start Overseer (id=88590845437149186-127.0.0.1:7000_solr-n_0000000000) starting
[junit4:junit4]   2> 847 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:create cxid:0x1a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 850 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:create cxid:0x1b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 851 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:create cxid:0x1c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 855 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:create cxid:0x1d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 856 T55 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 857 T42 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4]   2> 860 T42 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 876 T54 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 894 T42 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 895 T42 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 895 T42 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 896 T42 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 897 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 898 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 898 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 1005 T42 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 1177 T42 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 1187 T42 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 1215 T42 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 2204 T42 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 2212 T42 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 2215 T42 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 2241 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2248 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 2252 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2255 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 2259 T42 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7000/
[junit4:junit4]   2> 2261 T42 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57e787
[junit4:junit4]   2> 2262 T42 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 2262 T42 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for MockDirWrapper(org.apache.lucene.store.RAMDirectory@1fa157c lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1988d36) assuming 'simple'
[junit4:junit4]   2> 2263 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7000 forceNew:false
[junit4:junit4]   2> 2263 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7000
[junit4:junit4]   2> 2263 T42 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7000/index/
[junit4:junit4]   2> 2263 T42 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7000/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 2264 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7000/index forceNew:false
[junit4:junit4]   2> 2267 T42 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@4479b2 lockFactory=org.apache.lucene.store.NativeFSLockFactory@712ee9),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 2267 T42 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 2268 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7000/index
[junit4:junit4]   2> 2268 T42 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 2270 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 2270 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 2271 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 2271 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 2272 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 2272 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 2273 T42 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 2274 T42 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 2275 T42 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 2276 T42 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 2277 T42 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 2278 T42 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 2279 T42 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 2279 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 2280 T42 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 2281 T42 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 2283 T42 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2284 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2286 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2287 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2289 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2290 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2291 T42 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 2295 T42 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 2296 T42 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 2302 T42 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 2304 T42 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 2306 T42 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 2308 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7000
[junit4:junit4]   2> 2309 T42 oass.SolrIndexSearcher.<init> Opening Searcher@190ed52 main
[junit4:junit4]   2> 2309 T42 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 2309 T42 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 2310 T42 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 2315 T42 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 2394 T56 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@190ed52 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 2406 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 2407 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:create cxid:0x59 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4]   2> 2414 T42 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 2415 T42 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7000/solr shardId:shard1
[junit4:junit4]   2> 2418 T42 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=10000&maxConnectionsPerHost=20&connTimeout=30000&socketTimeout=30000&retry=false
[junit4:junit4]   2> 2429 T42 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4]   2> 2455 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:delete cxid:0x68 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders
[junit4:junit4]   2> 2456 T42 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 2457 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:create cxid:0x69 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 2903 T54 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 2904 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7000_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7000/solr"}
[junit4:junit4]   2> 2910 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:create cxid:0x70 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4]   2> 2930 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 2963 T42 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 2964 T42 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 2964 T42 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 2965 T42 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 2971 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20002 type:create cxid:0x8f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3440 T54 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3446 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 3474 T42 oasc.ZkController.register We are http://127.0.0.1:7000/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 3474 T42 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 3475 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 3477 T42 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3479 T42 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 3480 T42 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 3480 T42 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 3481 T42 oasc.CoreContainer.<init> New CoreContainer 17404503
[junit4:junit4]   2> 3481 T42 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 3482 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 3514 T42 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 3530 T42 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47385/solr
[junit4:junit4]   2> 3530 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@fe6707
[junit4:junit4]   2> 3531 T57 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 3531 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 3532 T57 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 3532 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35646
[junit4:junit4]   2> 3532 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35646
[junit4:junit4]   2> 3533 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20003 with negotiated timeout 3000 for client /127.0.0.1:35646
[junit4:junit4]   2> 3533 T57 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20003, negotiated timeout = 3000
[junit4:junit4]   2> 3533 T58 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@fe6707 name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 3534 T42 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 3535 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3537 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 3539 T42 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7001_solr
[junit4:junit4]   2> 3540 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7001_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7001_solr
[junit4:junit4]   2> 3540 T42 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7001_solr
[junit4:junit4]   2> 3543 T53 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 3543 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 3543 T42 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 3543 T42 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 3544 T42 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 3544 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 3544 T42 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 3545 T42 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 3545 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 3546 T42 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 3546 T42 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 3547 T42 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 3555 T42 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 3565 T42 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 3566 T42 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 3567 T42 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 3567 T42 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 3569 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 3570 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 3571 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 3618 T42 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 3696 T42 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 3698 T42 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 3712 T42 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 3952 T54 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 3954 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7000_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7000/solr"}
[junit4:junit4]   2> 3961 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 3969 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 4472 T42 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 4488 T42 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 4493 T42 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 4517 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4525 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 4530 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4532 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 4535 T42 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7001/
[junit4:junit4]   2> 4536 T42 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57e787
[junit4:junit4]   2> 4537 T42 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 4538 T42 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@1fd9726 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1ce67ca) assuming 'simple'
[junit4:junit4]   2> 4539 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7001 forceNew:false
[junit4:junit4]   2> 4539 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7001
[junit4:junit4]   2> 4539 T42 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7001/index/
[junit4:junit4]   2> 4539 T42 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7001/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 4540 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7001/index forceNew:false
[junit4:junit4]   2> 4541 T42 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@53ccba lockFactory=org.apache.lucene.store.NativeFSLockFactory@cc17f1),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 4542 T42 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 4543 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7001/index
[junit4:junit4]   2> 4543 T42 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 4546 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 4547 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 4547 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 4548 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 4549 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 4549 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 4549 T42 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 4551 T42 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 4553 T42 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 4554 T42 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 4555 T42 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 4555 T42 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 4556 T42 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 4556 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 4557 T42 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 4558 T42 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 4559 T42 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4560 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4562 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4563 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4565 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4567 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4568 T42 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 4570 T42 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 4571 T42 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 4576 T42 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 4579 T42 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 4581 T42 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 4585 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7001
[junit4:junit4]   2> 4585 T42 oass.SolrIndexSearcher.<init> Opening Searcher@2b7fc2 main
[junit4:junit4]   2> 4586 T42 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 4586 T42 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 4586 T42 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 4590 T42 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 4642 T59 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2b7fc2 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 4654 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 4658 T42 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 4659 T42 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7001/solr shardId:shard1
[junit4:junit4]   2> 4675 T42 oasc.ZkController.register We are http://127.0.0.1:7001/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 4676 T42 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 4676 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 4678 T42 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4686 T42 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 4687 T42 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 4688 T42 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 4688 T42 oasc.CoreContainer.<init> New CoreContainer 8096743
[junit4:junit4]   2> 4689 T42 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 4690 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 4715 T42 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 4729 T42 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47385/solr
[junit4:junit4]   2> 4730 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@be9340
[junit4:junit4]   2> 4731 T60 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 4732 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 4734 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35647
[junit4:junit4]   2> 4735 T60 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 4735 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35647
[junit4:junit4]   2> 4736 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20004 with negotiated timeout 3000 for client /127.0.0.1:35647
[junit4:junit4]   2> 4736 T60 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20004, negotiated timeout = 3000
[junit4:junit4]   2> 4737 T61 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@be9340 name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 4737 T42 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 4738 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20004 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4739 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20004 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 4741 T42 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7002_solr
[junit4:junit4]   2> 4741 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20004 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7002_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7002_solr
[junit4:junit4]   2> 4742 T42 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7002_solr
[junit4:junit4]   2> 4746 T58 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 4747 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4747 T42 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 4748 T42 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 4748 T42 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 4748 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 4749 T42 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 4749 T42 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 4749 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 4749 T42 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 4749 T42 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 4750 T53 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 4750 T42 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 4750 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4766 T42 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 4775 T42 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 4775 T42 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 4781 T42 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 4782 T42 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 4784 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 4785 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 4785 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 4833 T42 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 4898 T42 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 4899 T42 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 4906 T42 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 4977 T54 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 4978 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7001_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7001/solr"}
[junit4:junit4]   2> 4986 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7001_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7001/solr"}
[junit4:junit4]   2> 4992 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4993 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 4993 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 5597 T42 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 5608 T42 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 5612 T42 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 5643 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5647 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 5653 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5660 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 5663 T42 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7002/
[junit4:junit4]   2> 5664 T42 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57e787
[junit4:junit4]   2> 5665 T42 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 5669 T42 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for MockDirWrapper(org.apache.lucene.store.RAMDirectory@6f956 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1db8a73) assuming 'simple'
[junit4:junit4]   2> 5669 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7002 forceNew:false
[junit4:junit4]   2> 5670 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7002
[junit4:junit4]   2> 5670 T42 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7002/index/
[junit4:junit4]   2> 5671 T42 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7002/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 5671 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7002/index forceNew:false
[junit4:junit4]   2> 5673 T42 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@92e96c lockFactory=org.apache.lucene.store.NativeFSLockFactory@17cf28b),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 5681 T42 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 5682 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7002/index
[junit4:junit4]   2> 5684 T42 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 5686 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 5687 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 5687 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 5688 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 5694 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 5695 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 5695 T42 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 5697 T42 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 5699 T42 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 5700 T42 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 5702 T42 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 5702 T42 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 5706 T42 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 5706 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 5707 T42 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 5709 T42 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 5710 T42 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5712 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5713 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5715 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5721 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5723 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5725 T42 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 5726 T42 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 5728 T42 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 5738 T42 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 5741 T42 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 5744 T42 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 5748 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7002
[junit4:junit4]   2> 5749 T42 oass.SolrIndexSearcher.<init> Opening Searcher@f00e0f main
[junit4:junit4]   2> 5750 T42 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 5750 T42 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 5752 T42 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 5764 T42 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 5826 T62 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f00e0f main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 5833 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 5835 T42 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 5835 T42 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7002/solr shardId:shard1
[junit4:junit4]   2> 5839 T42 oasc.ZkController.register We are http://127.0.0.1:7002/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 5839 T42 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 5839 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 5841 T42 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 5843 T42 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 5844 T42 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 5844 T42 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 5845 T42 oasc.CoreContainer.<init> New CoreContainer 23465250
[junit4:junit4]   2> 5857 T42 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 5858 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 5897 T42 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 5916 T42 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47385/solr
[junit4:junit4]   2> 5916 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@1670cc6
[junit4:junit4]   2> 5919 T63 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 5919 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 5923 T63 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 5923 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35648
[junit4:junit4]   2> 5923 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35648
[junit4:junit4]   2> 5925 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20005 with negotiated timeout 3000 for client /127.0.0.1:35648
[junit4:junit4]   2> 5925 T63 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20005, negotiated timeout = 3000
[junit4:junit4]   2> 5925 T64 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1670cc6 name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 5925 T42 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 5927 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20005 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5928 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20005 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 5930 T42 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7003_solr
[junit4:junit4]   2> 5932 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20005 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7003_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7003_solr
[junit4:junit4]   2> 5932 T42 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7003_solr
[junit4:junit4]   2> 5947 T58 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 5947 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5948 T61 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 5949 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5949 T42 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 5950 T53 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 5950 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 5950 T42 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 5950 T42 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 5951 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 5951 T42 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 5952 T42 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 5952 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 5952 T42 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 5953 T42 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 5953 T42 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 5980 T42 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 5989 T42 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 5990 T42 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 5991 T42 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 5991 T42 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 5993 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 5993 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 5994 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 6011 T54 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6012 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7002_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7002/solr"}
[junit4:junit4]   2> 6018 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7002_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7002/solr"}
[junit4:junit4]   2> 6023 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 6023 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 6023 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 6025 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 6075 T42 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 6159 T42 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 6160 T42 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 6167 T42 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 6820 T42 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 6833 T42 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 6837 T42 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 6871 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 6877 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 6889 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 6892 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 6895 T42 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7003/
[junit4:junit4]   2> 6895 T42 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57e787
[junit4:junit4]   2> 6896 T42 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 6898 T42 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for MockDirWrapper(org.apache.lucene.store.MMapDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/index5183951841tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@d98b00) assuming 'simple'
[junit4:junit4]   2> 6898 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7003 forceNew:false
[junit4:junit4]   2> 6899 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7003
[junit4:junit4]   2> 6899 T42 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7003/index/
[junit4:junit4]   2> 6900 T42 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7003/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 6901 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7003/index forceNew:false
[junit4:junit4]   2> 6902 T42 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@65ab77 lockFactory=org.apache.lucene.store.NativeFSLockFactory@7413e8),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 6903 T42 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 6903 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7003/index
[junit4:junit4]   2> 6903 T42 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 6905 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 6906 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 6906 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 6907 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 6908 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 6908 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 6909 T42 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 6911 T42 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 6912 T42 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 6913 T42 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 6915 T42 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 6915 T42 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 6916 T42 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 6917 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 6917 T42 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 6918 T42 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 6919 T42 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6920 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6922 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6923 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6925 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6926 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6927 T42 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 6928 T42 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 6929 T42 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 6932 T42 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 6934 T42 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 6935 T42 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 6937 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7003
[junit4:junit4]   2> 6938 T42 oass.SolrIndexSearcher.<init> Opening Searcher@128cad main
[junit4:junit4]   2> 6939 T42 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 6939 T42 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 6940 T42 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 6947 T42 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 6977 T65 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@128cad main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 6983 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 6985 T42 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 6985 T42 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7003/solr shardId:shard1
[junit4:junit4]   2> 6988 T42 oasc.ZkController.register We are http://127.0.0.1:7003/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 6989 T42 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 6989 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 6991 T42 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 6993 T42 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 6993 T42 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 6993 T42 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 6994 T42 oasc.CoreContainer.<init> New CoreContainer 22074838
[junit4:junit4]   2> 6994 T42 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 6995 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 7012 T42 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 7030 T42 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47385/solr
[junit4:junit4]   2> 7031 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@10285d8
[junit4:junit4]   2> 7031 T66 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 7031 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 7032 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35649
[junit4:junit4]   2> 7033 T66 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 7034 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35649
[junit4:junit4]   2> 7036 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20006 with negotiated timeout 3000 for client /127.0.0.1:35649
[junit4:junit4]   2> 7036 T66 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20006, negotiated timeout = 3000
[junit4:junit4]   2> 7036 T67 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@10285d8 name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 7037 T42 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 7037 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 7040 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 7040 T54 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7042 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7003_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7003/solr"}
[junit4:junit4]   2> 7042 T42 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7004_solr
[junit4:junit4]   2> 7043 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7004_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7004_solr
[junit4:junit4]   2> 7043 T42 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7004_solr
[junit4:junit4]   2> 7046 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 7047 T58 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 7047 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7047 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7003_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7003/solr"}
[junit4:junit4]   2> 7047 T61 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 7047 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7048 T42 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 7049 T42 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 7049 T64 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 7049 T42 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 7049 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 7049 T42 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 7050 T42 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 7050 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 7051 T42 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 7051 T42 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 7051 T42 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 7053 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7053 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7053 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7071 T42 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 7072 T53 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 7072 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7073 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 7080 T42 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 7080 T42 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 7081 T42 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 7090 T42 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 7092 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 7093 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 7094 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 7153 T42 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 7227 T42 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 7228 T42 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 7236 T42 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 7804 T42 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 7814 T42 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 7818 T42 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 7845 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 7849 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 7853 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 7855 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 7857 T42 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7004/
[junit4:junit4]   2> 7858 T42 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57e787
[junit4:junit4]   2> 7858 T42 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 7860 T42 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for MockDirWrapper(org.apache.lucene.store.RAMDirectory@17b650a lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@267b76) assuming 'simple'
[junit4:junit4]   2> 7860 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7004 forceNew:false
[junit4:junit4]   2> 7861 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7004
[junit4:junit4]   2> 7861 T42 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7004/index/
[junit4:junit4]   2> 7861 T42 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7004/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 7862 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7004/index forceNew:false
[junit4:junit4]   2> 7863 T42 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@26db62 lockFactory=org.apache.lucene.store.NativeFSLockFactory@114629),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 7864 T42 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 7864 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7004/index
[junit4:junit4]   2> 7865 T42 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 7867 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 7867 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 7867 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 7868 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 7868 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 7869 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 7869 T42 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 7871 T42 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 7872 T42 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 7874 T42 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 7875 T42 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 7876 T42 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 7877 T42 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 7878 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 7878 T42 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 7879 T42 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 7880 T42 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7881 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7882 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7883 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7884 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7885 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7886 T42 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 7887 T42 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 7888 T42 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 7891 T42 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 7901 T42 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 7903 T42 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 7905 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7004
[junit4:junit4]   2> 7905 T42 oass.SolrIndexSearcher.<init> Opening Searcher@1b75be2 main
[junit4:junit4]   2> 7906 T42 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 7906 T42 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 7907 T42 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 7911 T42 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 7952 T68 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b75be2 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 7968 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 7973 T42 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 7973 T42 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7004/solr shardId:shard1
[junit4:junit4]   2> 7981 T42 oasc.ZkController.register We are http://127.0.0.1:7004/solr/collection1/ and leader is http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 7982 T42 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 7982 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 7984 T42 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 7986 T42 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   2> 7986 T42 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4]   2> 7986 T42 oasc.CoreContainer$Initializer.initialize looking for solr.xml: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/solr.xml
[junit4:junit4]   2> 7987 T42 oasc.CoreContainer.<init> New CoreContainer 32141780
[junit4:junit4]   2> 7987 T42 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 7987 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4]   2> 8012 T42 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4]   2> 8039 T42 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:47385/solr
[junit4:junit4]   2> 8039 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@1a9ec16
[junit4:junit4]   2> 8040 T69 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 8040 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 8041 T69 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 8041 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35650
[junit4:junit4]   2> 8042 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35650
[junit4:junit4]   2> 8043 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20007 with negotiated timeout 3000 for client /127.0.0.1:35650
[junit4:junit4]   2> 8044 T69 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20007, negotiated timeout = 3000
[junit4:junit4]   2> 8044 T70 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1a9ec16 name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 8045 T42 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 8046 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:create cxid:0x1 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 8047 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:create cxid:0x2 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 8048 T42 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:3333_solr
[junit4:junit4]   2> 8048 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:delete cxid:0x4 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:3333_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:3333_solr
[junit4:junit4]   2> 8049 T42 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:3333_solr
[junit4:junit4]   2> 8051 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 8051 T53 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 8051 T61 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 8052 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 8052 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 8052 T58 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 8052 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 8053 T67 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 8054 T42 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4]   2> 8054 T64 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 8054 T42 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4]   2> 8054 T42 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4]   2> 8055 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4]   2> 8056 T42 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4]   2> 8056 T42 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4]   2> 8057 T42 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4]   2> 8057 T42 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4]   2> 8058 T42 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4]   2> 8058 T42 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4]   2> 8067 T42 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 8075 T54 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 8077 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7004_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7004/solr"}
[junit4:junit4]   2> 8077 T42 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4]   2> 8078 T42 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4]   2> 8079 T42 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4]   2> 8079 T42 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4]   2> 8082 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7004_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7004/solr"}
[junit4:junit4]   2> 8086 T42 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4]   2> 8087 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4]   2> 8088 T42 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4]   2> 8090 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 8090 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 8091 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 8090 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 8096 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 8096 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 8136 T42 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   2> 8200 T42 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   2> 8202 T42 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4]   2> 8212 T42 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4]   2> 8908 T42 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4]   2> 8923 T42 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4]   2> 8927 T42 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4]   2> 8954 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 8966 T42 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4]   2> 8972 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 8985 T42 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4]   2> 8990 T42 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_3333/
[junit4:junit4]   2> 8991 T42 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@57e787
[junit4:junit4]   2> 8991 T42 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   2> 8992 T42 oasc.CachingDirectoryFactory.injectLockFactory WARNING No lockType configured for MockDirWrapper(org.apache.lucene.store.RAMDirectory@1941dc9 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@12fa617) assuming 'simple'
[junit4:junit4]   2> 8993 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_3333 forceNew:false
[junit4:junit4]   2> 8994 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_3333
[junit4:junit4]   2> 8994 T42 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_3333/index/
[junit4:junit4]   2> 8994 T42 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_3333/index' doesn't exist. Creating new index...
[junit4:junit4]   2> 8995 T42 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_3333/index forceNew:false
[junit4:junit4]   2> 8997 T42 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4]   2> 		commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@c510e3 lockFactory=org.apache.lucene.store.NativeFSLockFactory@13c339f; maxCacheMB=0.3447265625 maxMergeSizeMB=0.7890625)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4]   2> 8998 T42 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4]   2> 8998 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_3333/index
[junit4:junit4]   2> 8999 T42 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4]   2> 9001 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4]   2> 9001 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4]   2> 9002 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4]   2> 9002 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4]   2> 9002 T42 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4]   2> 9003 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4]   2> 9003 T42 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4]   2> 9004 T42 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4]   2> 9007 T42 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4]   2> 9008 T42 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4]   2> 9010 T42 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4]   2> 9011 T42 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4]   2> 9013 T42 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4]   2> 9013 T42 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4]   2> 9014 T42 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4]   2> 9015 T42 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4]   2> 9016 T42 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9018 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9020 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9022 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9023 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9025 T42 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9026 T42 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4]   2> 9028 T42 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4]   2> 9029 T42 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   2> 9034 T42 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4]   2> 9036 T42 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4]   2> 9038 T42 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [SCHEMA.XML, OLD_SYNONYMS.TXT, STOPWORDS.TXT, PROTWORDS.TXT, OPEN-EXCHANGE-RATES.JSON, SYNONYMS.TXT, CURRENCY.XML, MAPPING-ISOLATIN1ACCENT.TXT]
[junit4:junit4]   2> 9041 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_3333
[junit4:junit4]   2> 9042 T42 oass.SolrIndexSearcher.<init> Opening Searcher@6baa51 main
[junit4:junit4]   2> 9042 T42 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4]   2> 9043 T42 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4]   2> 9043 T42 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4]   2> 9048 T42 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4]   2> 9087 T71 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6baa51 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   2> 9094 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 9096 T42 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4]   2> 9096 T42 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:3333/solr shardId:shard2
[junit4:junit4]   2> 9097 T42 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election
[junit4:junit4]   2> 9108 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:delete cxid:0x42 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard2 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard2
[junit4:junit4]   2> 9108 T42 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 9110 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:create cxid:0x43 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 9117 T54 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 9118 T54 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:3333_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:3333/solr"}
[junit4:junit4]   2> 9129 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9129 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9129 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9129 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9130 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9130 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9614 T42 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4]   2> 9615 T42 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 9615 T42 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:3333/solr/collection1/
[junit4:junit4]   2> 9616 T42 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2
[junit4:junit4]   2> 9620 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:create cxid:0x4e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 9639 T54 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 9645 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9645 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9645 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9645 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9645 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9645 T53 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 9672 T42 oasc.ZkController.register We are http://127.0.0.1:3333/solr/collection1/ and leader is http://127.0.0.1:3333/solr/collection1/
[junit4:junit4]   2> 9673 T42 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 9673 T42 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 9676 T42 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 9677 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1bc6ed3
[junit4:junit4]   2> 9678 T72 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 9679 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35651
[junit4:junit4]   2> 9679 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 9680 T72 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 9680 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35651
[junit4:junit4]   2> 9682 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20008 with negotiated timeout 10000 for client /127.0.0.1:35651
[junit4:junit4]   2> 9682 T72 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20008, negotiated timeout = 10000
[junit4:junit4]   2> 9682 T73 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1bc6ed3 name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 9682 T42 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 9688 T42 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 9690 T42 oasc.LeaderElectionIntegrationTest.setUp ####SETUP_END testLeaderElectionAfterClientTimeout
[junit4:junit4]   2> 9692 T44 oazs.NIOServerCnxn.doIO WARNING EndOfStreamException: Unable to read additional data from client sessionid 0x13abce790a20002, likely client has closed socket
[junit4:junit4]   2> 9693 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35645 which had sessionid 0x13abce790a20002
[junit4:junit4]   2> 10651 T52 oaz.ClientCnxn$SendThread.run WARNING Session 0x13abce790a20002 for server null, unexpected error, closing socket connection and attempting reconnect java.nio.channels.CancelledKeyException
[junit4:junit4]   2> 	at sun.nio.ch.SelectionKeyImpl.ensureValid(SelectionKeyImpl.java:55)
[junit4:junit4]   2> 	at sun.nio.ch.SelectionKeyImpl.interestOps(SelectionKeyImpl.java:59)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.disableWrite(ClientCnxn.java:919)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1163)
[junit4:junit4]   2> 
[junit4:junit4]   2> 12794 T53 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@167198e name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:Disconnected type:None path:null path:null type:None
[junit4:junit4]   2> 12795 T53 oascc.ConnectionManager.process zkClient has disconnected
[junit4:junit4]   2> 12858 T45 oazs.ZooKeeperServer.expire Expiring session 0x13abce790a20002, timeout of 3000ms exceeded
[junit4:junit4]   2> 12858 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20002
[junit4:junit4]   2> 12859 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 12860 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 12861 T73 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 12861 T67 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 12861 T61 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 12861 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 12861 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:delete cxid:0x58 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 12861 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 12862 T58 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 12863 T64 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 12866 T70 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 12872 T58 oasc.Overseer.start Overseer (id=88590845437149187-127.0.0.1:7001_solr-n_0000000001) starting
[junit4:junit4]   2> 12872 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:create cxid:0x5d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 12873 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:create cxid:0x5e zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 12874 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:create cxid:0x5f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 12875 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:create cxid:0x60 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 12878 T76 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 12879 T75 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 12880 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:delete cxid:0x65 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard1 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard1
[junit4:junit4]   2> 12880 T58 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 12881 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:create cxid:0x69 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 12882 T58 oasc.ShardLeaderElectionContext.shouldIBeLeader Checking if I should try and be the leader.
[junit4:junit4]   2> 12882 T75 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 12883 T58 oasc.ShardLeaderElectionContext.shouldIBeLeader My last published State was Active, it's okay to be the leader.
[junit4:junit4]   2> 12883 T58 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 12883 T58 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:7001/solr/collection1/
[junit4:junit4]   2> 12883 T75 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard2",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:3333_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:3333/solr"}
[junit4:junit4]   2> 12883 T58 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 12889 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20003 type:create cxid:0x7b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 12908 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 12908 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 12908 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 12908 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 12908 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 12916 T58 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 12916 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 12918 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 14116 T52 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:47385
[junit4:junit4]   2> 14116 T52 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 14116 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35652
[junit4:junit4]   2> 14118 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to renew session 0x13abce790a20002 at /127.0.0.1:35652
[junit4:junit4]   2> 14119 T44 oazs.NIOServerCnxn.finishSessionInit Invalid session 0x13abce790a20002 for client /127.0.0.1:35652, probably expired
[junit4:junit4]   2> 14119 T53 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@167198e name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:Expired type:None path:null path:null type:None
[junit4:junit4]   2> 14119 T52 oaz.ClientCnxn$SendThread.run Unable to reconnect to ZooKeeper service, session 0x13abce790a20002 has expired, closing socket connection
[junit4:junit4]   2> 14119 T53 oascc.ConnectionManager.process Our previous ZooKeeper session was expired. Attempting to reconnect to recover relationship with ZooKeeper...
[junit4:junit4]   2> 14120 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35652 which had sessionid 0x13abce790a20002
[junit4:junit4]   2> 14120 T53 oascc.DefaultConnectionStrategy.reconnect Connection expired - starting a new one...
[junit4:junit4]   2> 14120 T53 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:47385/solr sessionTimeout=3000 watcher=org.apache.solr.common.cloud.ConnectionManager@167198e
[junit4:junit4]   2> 14121 T77 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:47385
[junit4:junit4]   2> 14121 T53 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 14121 T77 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:47385, initiating session
[junit4:junit4]   2> 14122 T44 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:35653
[junit4:junit4]   2> 14122 T44 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:35653
[junit4:junit4]   2> 14123 T46 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce790a20009 with negotiated timeout 3000 for client /127.0.0.1:35653
[junit4:junit4]   2> 14123 T77 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:47385, sessionid = 0x13abce790a20009, negotiated timeout = 3000
[junit4:junit4]   2> 14123 T78 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@167198e name:ZooKeeperConnection Watcher:127.0.0.1:47385/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4]   2> 14123 T53 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4]   2> 14123 T53 oascc.ConnectionManager$1.update Connection with ZooKeeper reestablished.
[junit4:junit4]   2> 14124 T53 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 14128 T53 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... 
[junit4:junit4]   2> 14129 T53 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 14129 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20009 type:delete cxid:0xa zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/live_nodes/127.0.0.1:7000_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 14130 T53 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:7000_solr
[junit4:junit4]   2> 14131 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 14131 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 14132 T61 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 14133 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14133 T73 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 14133 T58 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 14133 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14133 T53 oasc.ZkController.register Register shard - core:collection1 address:http://127.0.0.1:7000/solr shardId:shard1
[junit4:junit4]   2> 14133 T67 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 14133 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14133 T78 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 14134 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14136 T70 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 14136 T64 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4:junit4]   2> 14138 T53 oasc.ZkController.register We are http://127.0.0.1:7000/solr/collection1/ and leader is http://127.0.0.1:7001/solr/collection1/
[junit4:junit4]   2> 14138 T53 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4]   2> 14138 T53 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4]   2> 14139 T53 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 14140 T53 oascc.DefaultConnectionStrategy.reconnect Reconnected to ZooKeeper
[junit4:junit4]   2> 14140 T53 oascc.ConnectionManager.process Connected:true
[junit4:junit4]   2> 14140 T53 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 14220 T54 oasc.Overseer$ClusterStateUpdater.amILeader WARNING  org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/leader
[junit4:junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:118)
[junit4:junit4]   2> 	at org.apache.zookeeper.KeeperException.create(KeeperException.java:42)
[junit4:junit4]   2> 	at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:927)
[junit4:junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:244)
[junit4:junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:241)
[junit4:junit4]   2> 	at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:63)
[junit4:junit4]   2> 	at org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:241)
[junit4:junit4]   2> 	at org.apache.solr.cloud.Overseer$ClusterStateUpdater.amILeader(Overseer.java:192)
[junit4:junit4]   2> 	at org.apache.solr.cloud.Overseer$ClusterStateUpdater.run(Overseer.java:116)
[junit4:junit4]   2> 	at java.lang.Thread.run(Thread.java:662)
[junit4:junit4]   2> 
[junit4:junit4]   2> 14220 T55 oasc.OverseerCollectionProcessor.run WARNING Overseer cannot talk to ZK
[junit4:junit4]   2> 14220 T54 oasc.Overseer$ClusterStateUpdater.amILeader According to ZK I (id=88590845437149186-127.0.0.1:7000_solr-n_0000000000) am no longer a leader.
[junit4:junit4]   2> 14420 T75 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 14421 T75 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"down",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7000_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7000/solr"}
[junit4:junit4]   2> 14424 T75 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4]   2> 	  "operation":"state",
[junit4:junit4]   2> 	  "numShards":null,
[junit4:junit4]   2> 	  "shard":"shard1",
[junit4:junit4]   2> 	  "roles":null,
[junit4:junit4]   2> 	  "state":"active",
[junit4:junit4]   2> 	  "core":"collection1",
[junit4:junit4]   2> 	  "collection":"collection1",
[junit4:junit4]   2> 	  "node_name":"127.0.0.1:7000_solr",
[junit4:junit4]   2> 	  "base_url":"http://127.0.0.1:7000/solr"}
[junit4:junit4]   2> 14427 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14427 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14428 T61 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14428 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14428 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14427 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 14428 T78 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 15096 T42 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=8096743
[junit4:junit4]   2> 15097 T42 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@a801b0
[junit4:junit4]   2> 15102 T42 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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}
[junit4:junit4]   2> 15103 T42 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 15103 T42 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 15103 T42 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 15104 T42 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 15105 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7002/index
[junit4:junit4]   2> 15106 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20004
[junit4:junit4]   2> 15107 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 15107 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (6)
[junit4:junit4]   2> 15107 T78 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 15108 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35647 which had sessionid 0x13abce790a20004
[junit4:junit4]   2> 15108 T78 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 15107 T42 oaz.ZooKeeper.close Session: 0x13abce790a20004 closed
[junit4:junit4]   2> 15108 T67 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 15108 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 15108 T73 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 15108 T58 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 15108 T42 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=23465250
[junit4:junit4]   2> 15109 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 15109 T42 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@751d58
[junit4:junit4]   2> 15110 T64 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 15109 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 15112 T70 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4:junit4]   2> 15118 T42 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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}
[junit4:junit4]   2> 15119 T42 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 15119 T42 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 15120 T42 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 15120 T42 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 15121 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7003/index
[junit4:junit4]   2> 15122 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20005
[junit4:junit4]   2> 15123 T64 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 15123 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (5)
[junit4:junit4]   2> 15123 T64 oascc.ZkStateReader$2.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 15123 T44 oazs.NIOServerCnxn.doIO WARNING EndOfStreamException: Unable to read additional data from client sessionid 0x13abce790a20005, likely client has closed socket
[junit4:junit4]   2> 15123 T42 oaz.ZooKeeper.close Session: 0x13abce790a20005 closed
[junit4:junit4]   2> 15124 T78 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 15123 T73 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 15123 T58 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 15123 T64 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 15125 T64 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 15124 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 15124 T78 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 15124 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35648 which had sessionid 0x13abce790a20005
[junit4:junit4]   2> 15124 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 15125 T42 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=17404503
[junit4:junit4]   2> 15126 T42 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@10ae3fb
[junit4:junit4]   2> 15127 T67 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 15127 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 15127 T70 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4:junit4]   2> 15133 T42 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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}
[junit4:junit4]   2> 15134 T42 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 15134 T42 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 15135 T42 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 15135 T42 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 15136 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7001/index
[junit4:junit4]   2> 15137 T75 oasc.Overseer$ClusterStateUpdater.amILeader According to ZK I (id=88590845437149187-127.0.0.1:7001_solr-n_0000000001) am no longer a leader.
[junit4:junit4]   2> 15137 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20003
[junit4:junit4]   2> 15138 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 15138 T58 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 15138 T44 oazs.NIOServerCnxn.doIO WARNING EndOfStreamException: Unable to read additional data from client sessionid 0x13abce790a20003, likely client has closed socket
[junit4:junit4]   2> 15138 T67 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 15138 T42 oaz.ZooKeeper.close Session: 0x13abce790a20003 closed
[junit4:junit4]   2> 15138 T73 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 15139 T42 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=22074838
[junit4:junit4]   2> 15138 T58 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (4)
[junit4:junit4]   2> 15139 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 15139 T42 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1dee0d7
[junit4:junit4]   2> 15139 T67 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 15139 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35646 which had sessionid 0x13abce790a20003
[junit4:junit4]   2> 15140 T58 oascc.ZkStateReader$2.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 15140 T58 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 15141 T78 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 15141 T78 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 15142 T70 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4:junit4]   2> 15143 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:delete cxid:0x5c zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 15143 T67 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 15145 T67 oasc.Overseer.start Overseer (id=88590845437149190-127.0.0.1:7004_solr-n_0000000004) starting
[junit4:junit4]   2> 15145 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:create cxid:0x61 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15146 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:create cxid:0x62 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15146 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:create cxid:0x63 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15147 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:create cxid:0x64 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15148 T80 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 15148 T42 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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}
[junit4:junit4]   2> 15148 T42 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 15149 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:delete cxid:0x68 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard1 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard1
[junit4:junit4]   2> 15149 T42 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 15149 T42 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 15149 T67 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 15150 T79 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 15150 T42 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 15150 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20006 type:create cxid:0x6b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15150 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7004/index
[junit4:junit4]   2> 15162 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20006
[junit4:junit4]   2> 15164 T44 oazs.NIOServerCnxn.doIO WARNING EndOfStreamException: Unable to read additional data from client sessionid 0x13abce790a20006, likely client has closed socket
[junit4:junit4]   2> 15164 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35649 which had sessionid 0x13abce790a20006
[junit4:junit4]   2> 15165 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:delete cxid:0x6a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 15164 T42 oaz.ZooKeeper.close Session: 0x13abce790a20006 closed
[junit4:junit4]   2> 15165 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20009 type:delete cxid:0x24 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/collections/collection1/leaders/shard1 Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders/shard1
[junit4:junit4]   2> 15165 T73 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 15165 T42 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=32141780
[junit4:junit4]   2> 15166 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 15166 T70 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 15166 T42 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@5284e9
[junit4:junit4]   2> 15166 T78 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4]   2> 15168 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20009 type:create cxid:0x25 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15170 T78 oasc.ShardLeaderElectionContext.shouldIBeLeader Checking if I should try and be the leader.
[junit4:junit4]   2> 15170 T78 oasc.ShardLeaderElectionContext.shouldIBeLeader My last published State was Active, it's okay to be the leader.
[junit4:junit4]   2> 15170 T78 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4]   2> 15170 T78 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://127.0.0.1:7000/solr/collection1/
[junit4:junit4]   2> 15171 T78 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4]   2> 15171 T70 oasc.Overseer.start Overseer (id=88590845437149191-127.0.0.1:3333_solr-n_0000000005) starting
[junit4:junit4]   2> 15172 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:create cxid:0x6f zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15173 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:create cxid:0x70 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15179 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:create cxid:0x71 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15180 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20007 type:create cxid:0x72 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15181 T82 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 15181 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (3)
[junit4:junit4]   2> 15181 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20009 type:create cxid:0x2d zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15183 T70 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 15183 T78 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4:junit4]   2> 15184 T78 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 15184 T81 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 15184 T42 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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}
[junit4:junit4]   2> 15185 T42 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 15185 T42 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 15185 T42 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 15186 T81 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 15186 T42 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 15186 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_3333/index
[junit4:junit4]   2> 15196 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20007
[junit4:junit4]   2> 15197 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35650 which had sessionid 0x13abce790a20007
[junit4:junit4]   2> 15197 T70 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (2)
[junit4:junit4]   2> 15198 T70 oascc.ZkStateReader$2.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 15198 T73 oascc.ZkStateReader$3.process Updating live nodes... (1)
[junit4:junit4]   2> 15198 T42 oaz.ZooKeeper.close Session: 0x13abce790a20007 closed
[junit4:junit4]   2> 15198 T70 oascc.ZkStateReader$3.process WARNING ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4:junit4]   2> 15198 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20009 type:delete cxid:0x33 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4]   2> 15198 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 15199 T70 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 15199 T78 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4]   2> 15201 T78 oasc.Overseer.start Overseer (id=88590845437149193-127.0.0.1:7000_solr-n_0000000007) starting
[junit4:junit4]   2> 15201 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20009 type:create cxid:0x38 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15202 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20009 type:create cxid:0x39 zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15203 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20009 type:create cxid:0x3a zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15204 T47 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13abce790a20009 type:create cxid:0x3b zxid:0xfffffffffffffffe txntype:unknown reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4]   2> 15205 T84 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4]   2> 15205 T78 oascc.ZkStateReader$3.process Updating live nodes... (1)
[junit4:junit4]   2> 15205 T78 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 15207 T83 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 15207 T83 oasc.Overseer$ClusterStateUpdater.run Replaying operations from work queue.
[junit4:junit4]   2> 15274 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 15280 T83 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4]   2> 15281 T78 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 15282 T83 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... 
[junit4:junit4]   2> 15291 T73 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 15297 T78 oascc.ZkStateReader$2.process A cluster state change has occurred - updating... (1)
[junit4:junit4]   2> 15299 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20008
[junit4:junit4]   2> 15300 T73 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 15300 T44 oazs.NIOServerCnxn.doIO WARNING EndOfStreamException: Unable to read additional data from client sessionid 0x13abce790a20008, likely client has closed socket
[junit4:junit4]   2> 15306 T42 oaz.ZooKeeper.close Session: 0x13abce790a20008 closed
[junit4:junit4]   2> 15306 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35651 which had sessionid 0x13abce790a20008
[junit4:junit4]   2> 15306 T42 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=32087476
[junit4:junit4]   2> 15307 T42 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1d26552
[junit4:junit4]   2> 15309 T42 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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}
[junit4:junit4]   2> 15309 T42 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 15310 T42 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 15310 T42 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 15310 T42 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 15311 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789023153/data_7000/index
[junit4:junit4]   2> 15312 T83 oasc.Overseer$ClusterStateUpdater.amILeader According to ZK I (id=88590845437149193-127.0.0.1:7000_solr-n_0000000007) am no longer a leader.
[junit4:junit4]   2> 15312 T47 oazs.PrepRequestProcessor.pRequest Processed session termination for sessionid: 0x13abce790a20009
[junit4:junit4]   2> 15313 T44 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:35653 which had sessionid 0x13abce790a20009
[junit4:junit4]   2> 15313 T42 oaz.ZooKeeper.close Session: 0x13abce790a20009 closed
[junit4:junit4]   2> 15314 T47 oazs.PrepRequestProcessor.run PrepRequestProcessor exited loop!
[junit4:junit4]   2> 15314 T46 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4]   2> 15315 T42 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4]   2> 15319 T44 oazs.NIOServerCnxn$Factory.run NIOServerCnxn factory exited run method
[junit4:junit4]   2> 15320 T42 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4]   2> 15320 T42 oas.SolrTestCaseJ4.tearDown ###Ending testLeaderElectionAfterClientTimeout
[junit4:junit4]   2> 15326 T42 oas.SolrTestCaseJ4.setUp ###Starting testSimpleSliceLeaderElection
[junit4:junit4]   2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789038469
[junit4:junit4]   2> 15327 T42 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 15328 T85 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4]   2> 15328 T85 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 15328 T85 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 15427 T42 oasc.ZkTestServer.run start zk server on port:38489
[junit4:junit4]   2> 15428 T42 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:38489 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1a42824
[junit4:junit4]   2> 15428 T90 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server /127.0.0.1:38489
[junit4:junit4]   2> 15428 T42 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4]   2> 15429 T90 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:38489, initiating session
[junit4:junit4]   2> 15429 T86 oazs.NIOServerCnxn$Factory.run Accepted socket connection from /127.0.0.1:44208
[junit4:junit4]   2> 15429 T86 oazs.NIOServerCnxn.readConnectRequest Client attempting to establish new session at /127.0.0.1:44208
[junit4:junit4]   2> 15430 T88 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 15431 T88 oazs.NIOServerCnxn.finishSessionInit Established session 0x13abce7cb880000 with negotiated timeout 10000 for client /127.0.0.1:44208
[junit4:junit4]   2> 15432 T90 oaz.ClientCnxn$SendThread.readConnectResult Session establishment complete on server localhost.localdomain/127.0.0.1:38489, sessionid = 0x13abce

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

xpected error, closing socket connection and attempting reconnect java.net.ConnectException: Connection refused
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:599)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1143)
[junit4:junit4]   2> 
[junit4:junit4]   2> 7221788 T99 oaz.ClientCnxn$SendThread.run WARNING Session 0x13abce7cb880003 for server null, unexpected error, closing socket connection and attempting reconnect java.net.ConnectException: Connection refused
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:599)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1143)
[junit4:junit4]   2> 
[junit4:junit4]   2> 7221789 T42 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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}
[junit4:junit4]   2> 7221790 T42 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 7221790 T42 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 7221791 T42 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 7221792 T42 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 7221792 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789038469/data_7001/index
[junit4:junit4]   2> 7221889 T42 oaz.ZooKeeper.close Session: 0x13abce7cb880003 closed
[junit4:junit4]   2> 7221889 T42 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=17305400
[junit4:junit4]   2> 7221890 T42 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@130fafb
[junit4:junit4]   2> 7221893 T42 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,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}
[junit4:junit4]   2> 7221894 T42 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4]   2> 7221894 T42 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   2> 7221894 T42 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4]   2> 7221894 T42 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4]   2> 7221895 T42 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-core/test/J0/./solrtest-LeaderElectionIntegrationTest-1351789038469/data_7004/index
[junit4:junit4]   2> 7222287 T94 oaz.ClientCnxn$SendThread.startConnect WARNING Unexpected exception java.lang.InterruptedException: sleep interrupted
[junit4:junit4]   2> 	at java.lang.Thread.sleep(Native Method)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1045)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1101)
[junit4:junit4]   2> 
[junit4:junit4]   2> 7222287 T108 oaz.ClientCnxn$SendThread.startConnect WARNING Unexpected exception java.lang.InterruptedException: sleep interrupted
[junit4:junit4]   2> 	at java.lang.Thread.sleep(Native Method)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1038)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1101)
[junit4:junit4]   2> 
[junit4:junit4]   2> 7222288 T94 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:38489
[junit4:junit4]   2> 7222287 T111 oaz.ClientCnxn$SendThread.startConnect WARNING Unexpected exception java.lang.InterruptedException: sleep interrupted
[junit4:junit4]   2> 	at java.lang.Thread.sleep(Native Method)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1045)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1101)
[junit4:junit4]   2> 
[junit4:junit4]   2> 7222287 T42 oaz.ZooKeeper.close Session: 0x13abce7cb880006 closed
[junit4:junit4]   2> 7222288 T111 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:38489
[junit4:junit4]   2> 7222288 T42 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=3998758
[junit4:junit4]   2> 7222289 T111 oaz.ClientCnxn$SendThread.run WARNING Session 0x13abce7cb880007 for server null, unexpected error, closing socket connection and attempting reconnect java.net.ConnectException: Connection refused
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:599)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1143)
[junit4:junit4]   2> 
[junit4:junit4]   2> 7222289 T42 oasc.SolrCore.close SEVERE Too many close [count:-1] on org.apache.solr.core.SolrCore@123b9c1. Please report this exception to solr-user@lucene.apache.org
[junit4:junit4]   2> 7222389 T42 oaz.ZooKeeper.close Session: 0x13abce7cb880007 closed
[junit4:junit4]   2> 7222390 T88 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4]   2> 7222390 T42 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4]   2> 7222393 T42 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4]   2> 7222393 T42 oas.SolrTestCaseJ4.tearDown ###Ending testSimpleSliceLeaderElection
[junit4:junit4]   2> 7222788 T108 oaz.ClientCnxn$SendThread.startConnect WARNING Unexpected exception java.lang.InterruptedException: sleep interrupted
[junit4:junit4]   2> 	at java.lang.Thread.sleep(Native Method)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.startConnect(ClientCnxn.java:1045)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1101)
[junit4:junit4]   2> 
[junit4:junit4]   2> 7222788 T42 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4]   2> 7222788 T108 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:38489
[junit4:junit4]   2> 7222800 T114 oaz.ClientCnxn$SendThread.startConnect Opening socket connection to server localhost.localdomain/127.0.0.1:38489
[junit4:junit4]   2> 7222800 T114 oaz.ClientCnxn$SendThread.run WARNING Session 0x0 for server null, unexpected error, closing socket connection and attempting reconnect java.net.ConnectException: Connection refused
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method)
[junit4:junit4]   2> 	at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:599)
[junit4:junit4]   2> 	at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1143)
[junit4:junit4]   2> 
[junit4:junit4]   2> 7222889 T41 ccr.ThreadLeakControl.tryToInterruptAll All leaked threads terminated.
[junit4:junit4]   2> NOTE: test params are: codec=SimpleText, sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=en_SG, timezone=Asia/Vientiane
[junit4:junit4]   2> NOTE: Linux 3.2.0-32-generic i386/Sun Microsystems Inc. 1.6.0_35 (32-bit)/cpus=8,threads=3,free=39020232,total=64946176
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestBinaryResponseWriter, TestRangeQuery, TestLFUCache, MinimalSchemaTest, JSONWriterTest, FastVectorHighlighterTest, IndexBasedSpellCheckerTest, TestSolrIndexConfig, NotRequiredUniqueKeyTest, LeaderElectionIntegrationTest]
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=LeaderElectionIntegrationTest -Dtests.seed=B7E150674CEF2EE1 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=en_SG -Dtests.timezone=Asia/Vientiane -Dtests.file.encoding=ISO-8859-1
[junit4:junit4] ERROR   0.00s J0 | LeaderElectionIntegrationTest (suite) <<<
[junit4:junit4]    > Throwable #1: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([B7E150674CEF2EE1]:0)
[junit4:junit4] Completed on J0 in 7222.92s, 2 tests, 2 errors <<< FAILURES!

[...truncated 154 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:335: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:178: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/module-build.xml:61: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1163: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:827: There were test failures: 233 suites, 965 tests, 1 suite-level error, 1 error, 7 ignored (2 assumptions)

Total time: 138 minutes 37 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 32bit/jdk1.6.0_35 -server -XX:+UseSerialGC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message