You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/01/12 06:13:51 UTC
[JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.6.0_38) - Build # 3709
- Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/3709/
Java: 32bit/jdk1.6.0_38 -server -XX:+UseSerialGC
1 tests failed.
REGRESSION: org.apache.solr.cloud.BasicZkTest.testBasic
Error Message:
Captured an uncaught exception in thread: Thread[id=68, name=Overseer-88995721107800067-188.138.97.18:null_solr-n_0000000000, state=RUNNABLE, group=Overseer collection creation process.]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=68, name=Overseer-88995721107800067-188.138.97.18:null_solr-n_0000000000, state=RUNNABLE, group=Overseer collection creation process.]
at __randomizedtesting.SeedInfo.seed([C4A85CE73DDC2252:6F5241F2E200A47C]:0)
Caused by: org.apache.solr.common.cloud.ZooKeeperException:
at __randomizedtesting.SeedInfo.seed([C4A85CE73DDC2252]:0)
at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:131)
at java.lang.Thread.run(Thread.java:662)
Caused by: org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode = NodeExists for /overseer/collection-queue-work
at org.apache.zookeeper.KeeperException.create(KeeperException.java:119)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:219)
at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:216)
at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:216)
at org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:277)
at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:100)
... 1 more
Build Log:
[...truncated 7942 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.BasicZkTest
[junit4:junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 19 T53 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4] 2> 23 T54 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4:junit4] 2> 135 T54 oaz.Environment.logEnv Server environment:zookeeper.version=3.4.5-1392090, built on 09/30/2012 17:52 GMT
[junit4:junit4] 2> 135 T54 oaz.Environment.logEnv Server environment:host.name=serv1
[junit4:junit4] 2> 135 T54 oaz.Environment.logEnv Server environment:java.version=1.6.0_38
[junit4:junit4] 2> 136 T54 oaz.Environment.logEnv Server environment:java.vendor=Sun Microsystems Inc.
[junit4:junit4] 2> 136 T54 oaz.Environment.logEnv Server environment:java.home=/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/jre
[junit4:junit4] 2> 136 T54 oaz.Environment.logEnv Server environment:java.class.path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/classes/test:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-test-framework/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/test-framework/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/codecs/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/analysis/common/lucene-analyzers-common-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/analysis/kuromoji/lucene-analyzers-kuromoji-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/analysis/phonetic/lucene-analyzers-phonetic-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/highlighter/lucene-highlighter-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/memory/lucene-memory-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/misc/lucene-misc-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/spatial/lucene-spatial-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/suggest/lucene-suggest-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/grouping/lucene-grouping-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/queries/lucene-queries-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/queryparser/lucene-queryparser-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/cglib-nodep-2.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/commons-cli-1.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/commons-codec-1.7.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/commons-fileupload-1.2.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/commons-lang-2.6.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/easymock-3.0.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/guava-13.0.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/javax.servlet-api-3.0.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/objenesis-1.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/spatial4j-0.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/commons-io-2.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/httpclient-4.1.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/httpcore-4.1.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/httpmime-4.1.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/jcl-over-slf4j-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/log4j-over-slf4j-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/slf4j-api-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/slf4j-jdk14-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/wstx-asl-3.2.7.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/zookeeper-3.4.5.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-continuation-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-deploy-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-http-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-io-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-jmx-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-security-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-server-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-servlet-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-util-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-webapp-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-xml-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/servlet-api-3.0.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/example-DIH/solr/db/lib/derby-10.9.1.0.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/example-DIH/solr/db/lib/hsqldb-1.8.0.10.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/test-framework/lib/junit-4.10.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/test-framework/lib/randomizedtesting-runner-2.0.8.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-launcher.jar:/var/lib/jenkins/.ant/lib/ivy-2.2.0.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jai.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-swing.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-oro.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jmf.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-xalan2.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-javamail.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-resolver.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-testutil.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-logging.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-log4j.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jsch.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-net.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bsf.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jdepend.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-netrexx.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-regexp.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit4.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bcel.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-antlr.jar:/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/lib/tools.jar:/var/lib/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.0.8.jar
[junit4:junit4] 2> 141 T54 oaz.Environment.logEnv Server environment:java.library.path=/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/jre/lib/i386/server:/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/jre/lib/i386:/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/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> 142 T54 oaz.Environment.logEnv Server environment:java.io.tmpdir=.
[junit4:junit4] 2> 142 T54 oaz.Environment.logEnv Server environment:java.compiler=<NA>
[junit4:junit4] 2> 142 T54 oaz.Environment.logEnv Server environment:os.name=Linux
[junit4:junit4] 2> 143 T54 oaz.Environment.logEnv Server environment:os.arch=i386
[junit4:junit4] 2> 143 T54 oaz.Environment.logEnv Server environment:os.version=3.2.0-35-generic
[junit4:junit4] 2> 143 T54 oaz.Environment.logEnv Server environment:user.name=jenkins
[junit4:junit4] 2> 143 T54 oaz.Environment.logEnv Server environment:user.home=/var/lib/jenkins
[junit4:junit4] 2> 144 T54 oaz.Environment.logEnv Server environment:user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4:junit4] 2> 164 T54 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4] 2> 164 T54 oazs.ZooKeeperServer.setMinSessionTimeout minSessionTimeout set to -1
[junit4:junit4] 2> 165 T54 oazs.ZooKeeperServer.setMaxSessionTimeout maxSessionTimeout set to -1
[junit4:junit4] 2> 266 T54 oazs.NIOServerCnxnFactory.configure binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4] 2> 298 T54 oazsp.FileTxnSnapLog.save Snapshotting: 0x0 to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/zookeeper/server1/data/version-2/snapshot.0
[junit4:junit4] 2> 323 T53 oasc.ZkTestServer.run start zk server on port:45582
[junit4:junit4] 2> 354 T53 oaz.Environment.logEnv Client environment:zookeeper.version=3.4.5-1392090, built on 09/30/2012 17:52 GMT
[junit4:junit4] 2> 355 T53 oaz.Environment.logEnv Client environment:host.name=serv1
[junit4:junit4] 2> 355 T53 oaz.Environment.logEnv Client environment:java.version=1.6.0_38
[junit4:junit4] 2> 356 T53 oaz.Environment.logEnv Client environment:java.vendor=Sun Microsystems Inc.
[junit4:junit4] 2> 356 T53 oaz.Environment.logEnv Client environment:java.home=/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/jre
[junit4:junit4] 2> 357 T53 oaz.Environment.logEnv Client environment:java.class.path=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/classes/test:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-test-framework/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/test-framework/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/codecs/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/analysis/common/lucene-analyzers-common-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/analysis/kuromoji/lucene-analyzers-kuromoji-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/analysis/phonetic/lucene-analyzers-phonetic-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/highlighter/lucene-highlighter-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/memory/lucene-memory-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/misc/lucene-misc-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/spatial/lucene-spatial-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/suggest/lucene-suggest-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/grouping/lucene-grouping-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/queries/lucene-queries-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/queryparser/lucene-queryparser-4.1-SNAPSHOT.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/cglib-nodep-2.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/commons-cli-1.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/commons-codec-1.7.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/commons-fileupload-1.2.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/commons-lang-2.6.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/easymock-3.0.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/guava-13.0.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/javax.servlet-api-3.0.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/objenesis-1.2.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/core/lib/spatial4j-0.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/commons-io-2.1.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/httpclient-4.1.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/httpcore-4.1.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/httpmime-4.1.3.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/jcl-over-slf4j-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/log4j-over-slf4j-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/slf4j-api-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/slf4j-jdk14-1.6.4.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/wstx-asl-3.2.7.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/solrj/lib/zookeeper-3.4.5.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-continuation-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-deploy-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-http-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-io-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-jmx-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-security-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-server-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-servlet-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-util-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-webapp-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/jetty-xml-8.1.8.v20121106.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/lib/servlet-api-3.0.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/example-DIH/solr/db/lib/derby-10.9.1.0.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/example-DIH/solr/db/lib/hsqldb-1.8.0.10.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/build/core/classes/java:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/test-framework/lib/junit-4.10.jar:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/test-framework/lib/randomizedtesting-runner-2.0.8.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-launcher.jar:/var/lib/jenkins/.ant/lib/ivy-2.2.0.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jai.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-swing.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-oro.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jmf.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-xalan2.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-javamail.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-resolver.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-testutil.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-logging.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-log4j.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jsch.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-commons-net.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bsf.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-jdepend.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-netrexx.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-regexp.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-junit4.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-apache-bcel.jar:/var/lib/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2/lib/ant-antlr.jar:/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/lib/tools.jar:/var/lib/jenkins/.ivy2/cache/com.carrotsearch.randomizedtesting/junit4-ant/jars/junit4-ant-2.0.8.jar
[junit4:junit4] 2> 358 T53 oaz.Environment.logEnv Client environment:java.library.path=/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/jre/lib/i386/server:/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/jre/lib/i386:/var/lib/jenkins/tools/java/32bit/jdk1.6.0_38/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> 358 T53 oaz.Environment.logEnv Client environment:java.io.tmpdir=.
[junit4:junit4] 2> 358 T53 oaz.Environment.logEnv Client environment:java.compiler=<NA>
[junit4:junit4] 2> 358 T53 oaz.Environment.logEnv Client environment:os.name=Linux
[junit4:junit4] 2> 359 T53 oaz.Environment.logEnv Client environment:os.arch=i386
[junit4:junit4] 2> 359 T53 oaz.Environment.logEnv Client environment:os.version=3.2.0-35-generic
[junit4:junit4] 2> 359 T53 oaz.Environment.logEnv Client environment:user.name=jenkins
[junit4:junit4] 2> 360 T53 oaz.Environment.logEnv Client environment:user.home=/var/lib/jenkins
[junit4:junit4] 2> 360 T53 oaz.Environment.logEnv Client environment:user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1
[junit4:junit4] 2> 362 T53 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:45582 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1ed7524
[junit4:junit4] 2> 392 T53 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 396 T59 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server localhost.localdomain/127.0.0.1:45582. Will not attempt to authenticate using SASL (access denied (javax.security.auth.AuthPermission getLoginConfiguration))
[junit4:junit4] 2> 399 T59 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:45582, initiating session
[junit4:junit4] 2> 849 T55 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:36999
[junit4:junit4] 2> 857 T55 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:36999
[junit4:junit4] 2> 861 T57 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4] 2> 904 T57 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c2d2307290000 with negotiated timeout 10000 for client /127.0.0.1:36999
[junit4:junit4] 2> 904 T59 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server localhost.localdomain/127.0.0.1:45582, sessionid = 0x13c2d2307290000, negotiated timeout = 10000
[junit4:junit4] 2> 907 T60 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1ed7524 name:ZooKeeperConnection Watcher:127.0.0.1:45582 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 908 T53 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 910 T53 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4] 2> 931 T58 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13c2d2307290000
[junit4:junit4] 2> 934 T53 oaz.ZooKeeper.close Session: 0x13c2d2307290000 closed
[junit4:junit4] 2> 935 T60 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4] 2> 935 T53 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:45582/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@129dcc0
[junit4:junit4] 2> 936 T55 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:36999 which had sessionid 0x13c2d2307290000
[junit4:junit4] 2> 936 T53 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 937 T61 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server localhost.localdomain/127.0.0.1:45582. Will not attempt to authenticate using SASL (access denied (javax.security.auth.AuthPermission getLoginConfiguration))
[junit4:junit4] 2> 938 T61 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:45582, initiating session
[junit4:junit4] 2> 955 T55 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:37004
[junit4:junit4] 2> 956 T55 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:37004
[junit4:junit4] 2> 957 T57 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c2d2307290001 with negotiated timeout 10000 for client /127.0.0.1:37004
[junit4:junit4] 2> 957 T61 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server localhost.localdomain/127.0.0.1:45582, sessionid = 0x13c2d2307290001, negotiated timeout = 10000
[junit4:junit4] 2> 958 T62 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@129dcc0 name:ZooKeeperConnection Watcher:127.0.0.1:45582/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 959 T53 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 969 T53 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4:junit4] 2> 977 T53 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4] 2> 982 T53 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4:junit4] 2> 986 T53 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4:junit4] 2> 992 T53 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/solrconfig.xml to /configs/conf1/solrconfig.xml
[junit4:junit4] 2> 1008 T53 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4:junit4] 2> 1077 T53 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4:junit4] 2> 1078 T53 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4:junit4] 2> 1083 T53 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4:junit4] 2> 1084 T53 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4:junit4] 2> 1088 T53 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4:junit4] 2> 1088 T53 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4:junit4] 2> 1092 T53 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4:junit4] 2> 1092 T53 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4:junit4] 2> 1095 T53 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4:junit4] 2> 1096 T53 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4:junit4] 2> 1099 T53 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4] 2> 1100 T53 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4:junit4] 2> 1103 T53 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4:junit4] 2> 1104 T53 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4:junit4] 2> 1107 T53 oasc.AbstractZkTestCase.putConfig put /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4:junit4] 2> 1107 T53 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4:junit4] 2> 1111 T58 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13c2d2307290001
[junit4:junit4] 2> 1112 T62 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4] 2> 1112 T53 oaz.ZooKeeper.close Session: 0x13c2d2307290001 closed
[junit4:junit4] 2> 1112 T55 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:37004 which had sessionid 0x13c2d2307290001
[junit4:junit4] 2> 1113 T53 oas.SolrTestCaseJ4.initCore ####initCore
[junit4:junit4] 2> 1113 T53 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4] 2> 1114 T53 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4] 2> 1114 T53 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 1181 T53 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_41
[junit4:junit4] 2> 1259 T53 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 1259 T53 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4] 2> 1297 T53 oass.IndexSchema.readSchema Schema name=test
[junit4:junit4] 2> 1763 T53 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4:junit4] 2> 1773 T53 oass.IndexSchema.readSchema default search field in schema is text
[junit4:junit4] 2> 1779 T53 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 1791 T53 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1794 T53 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1797 T53 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1800 T53 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4:junit4] 2> 1802 T53 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 1802 T53 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr
[junit4:junit4] 2> 1802 T53 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/'
[junit4:junit4] 2> 1809 T53 oasc.CoreContainer.<init> New CoreContainer 6928382
[junit4:junit4] 2> 1809 T53 oasc.CoreContainer.initZooKeeper Zookeeper client=127.0.0.1:45582/solr
[junit4:junit4] 2> 1818 T53 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4:junit4] 2> 1819 T53 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:45582 sessionTimeout=60000 watcher=org.apache.solr.common.cloud.ConnectionManager@8825a5
[junit4:junit4] 2> 1820 T53 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 1820 T63 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server localhost.localdomain/127.0.0.1:45582. Will not attempt to authenticate using SASL (access denied (javax.security.auth.AuthPermission getLoginConfiguration))
[junit4:junit4] 2> 1820 T63 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:45582, initiating session
[junit4:junit4] 2> 1820 T55 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:37006
[junit4:junit4] 2> 1821 T55 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:37006
[junit4:junit4] 2> 1822 T57 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c2d2307290002 with negotiated timeout 20000 for client /127.0.0.1:37006
[junit4:junit4] 2> 1822 T63 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server localhost.localdomain/127.0.0.1:45582, sessionid = 0x13c2d2307290002, negotiated timeout = 20000
[junit4:junit4] 2> 1823 T64 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8825a5 name:ZooKeeperConnection Watcher:127.0.0.1:45582 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 1823 T53 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 1824 T58 oazs.PrepRequestProcessor.pRequest2Txn Processed session termination for sessionid: 0x13c2d2307290002
[junit4:junit4] 2> 1825 T64 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4] 2> 1825 T55 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:37006 which had sessionid 0x13c2d2307290002
[junit4:junit4] 2> 1825 T53 oaz.ZooKeeper.close Session: 0x13c2d2307290002 closed
[junit4:junit4] 2> 1836 T53 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=500&maxConnectionsPerHost=16&socketTimeout=0&connTimeout=0
[junit4:junit4] 2> 2114 T53 oaz.ZooKeeper.<init> Initiating client connection, connectString=127.0.0.1:45582/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@6e056e
[junit4:junit4] 2> 2115 T53 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4:junit4] 2> 2115 T65 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server localhost.localdomain/127.0.0.1:45582. Will not attempt to authenticate using SASL (access denied (javax.security.auth.AuthPermission getLoginConfiguration))
[junit4:junit4] 2> 2115 T65 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:45582, initiating session
[junit4:junit4] 2> 2116 T55 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:37007
[junit4:junit4] 2> 2116 T55 oazs.ZooKeeperServer.processConnectRequest Client attempting to establish new session at /127.0.0.1:37007
[junit4:junit4] 2> 2121 T57 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c2d2307290003 with negotiated timeout 10000 for client /127.0.0.1:37007
[junit4:junit4] 2> 2121 T65 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server localhost.localdomain/127.0.0.1:45582, sessionid = 0x13c2d2307290003, negotiated timeout = 10000
[junit4:junit4] 2> 2121 T66 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6e056e name:ZooKeeperConnection Watcher:127.0.0.1:45582/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 2122 T53 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4:junit4] 2> 2140 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x2 zxid:0x1a txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 2157 T53 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4:junit4] 2> 2169 T53 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/188.138.97.18:null_solr
[junit4:junit4] 2> 2171 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:delete cxid:0x7 zxid:0x1c txntype:-1 reqpath:n/a Error Path:/solr/live_nodes/188.138.97.18:null_solr Error:KeeperErrorCode = NoNode for /solr/live_nodes/188.138.97.18:null_solr
[junit4:junit4] 2> 2180 T53 oascc.SolrZkClient.makePath makePath: /live_nodes/188.138.97.18:null_solr
[junit4:junit4] 2> 2190 T53 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4:junit4] 2> 2215 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:delete cxid:0x15 zxid:0x21 txntype:-1 reqpath:n/a Error Path:/solr/overseer_elect/leader Error:KeeperErrorCode = NoNode for /solr/overseer_elect/leader
[junit4:junit4] 2> 2223 T53 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4:junit4] 2> 2236 T53 oasc.Overseer.start Overseer (id=88995721107800067-188.138.97.18:null_solr-n_0000000000) starting
[junit4:junit4] 2> 2237 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x1a zxid:0x23 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 2317 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x1b zxid:0x24 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 2342 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x1c zxid:0x25 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 2391 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x1d zxid:0x26 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 2431 T68 oasc.OverseerCollectionProcessor.run Process current queue of collection messages
[junit4:junit4] 2> 2431 T53 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4:junit4] 2> 2474 T53 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4:junit4] 2> 9208 T65 oaz.ClientCnxn$SendThread.run Client session timed out, have not heard from server in 6669ms for sessionid 0x13c2d2307290003, closing socket connection and attempting reconnect
[junit4:junit4] 2> 9208 T55 oazs.NIOServerCnxn.doIO WARNING caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x13c2d2307290003, likely client has closed socket
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4:junit4] 2> at java.lang.Thread.run(Thread.java:662)
[junit4:junit4] 2>
[junit4:junit4] 2> 9209 T55 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:37007 which had sessionid 0x13c2d2307290003
[junit4:junit4] 2> 9309 T66 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6e056e name:ZooKeeperConnection Watcher:127.0.0.1:45582/solr got event WatchedEvent state:Disconnected type:None path:null path:null type:None
[junit4:junit4] 2> 9310 T66 oascc.ConnectionManager.process zkClient has disconnected
[junit4:junit4] 2> 9915 T57 oazsp.FileTxnLog.commit WARNING fsync-ing the write ahead log in SyncThread:0 took 7376ms which will adversely effect operation latency. See the ZooKeeper troubleshooting guide
[junit4:junit4] 2> 9916 T57 oazs.NIOServerCnxn.sendBuffer SEVERE Unexpected Exception: 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.server.NIOServerCnxn.sendBuffer(NIOServerCnxn.java:153)
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.sendResponse(NIOServerCnxn.java:1076)
[junit4:junit4] 2> at org.apache.zookeeper.server.FinalRequestProcessor.processRequest(FinalRequestProcessor.java:404)
[junit4:junit4] 2> at org.apache.zookeeper.server.SyncRequestProcessor.flush(SyncRequestProcessor.java:167)
[junit4:junit4] 2> at org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:101)
[junit4:junit4] 2>
[junit4:junit4] 2> 9917 T57 oazs.NIOServerCnxn.sendBuffer SEVERE Unexpected Exception: 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.server.NIOServerCnxn.sendBuffer(NIOServerCnxn.java:153)
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.sendResponse(NIOServerCnxn.java:1076)
[junit4:junit4] 2> at org.apache.zookeeper.server.FinalRequestProcessor.processRequest(FinalRequestProcessor.java:404)
[junit4:junit4] 2> at org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:138)
[junit4:junit4] 2>
[junit4:junit4] 2> 9918 T57 oazs.NIOServerCnxn.sendBuffer SEVERE Unexpected Exception: 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.server.NIOServerCnxn.sendBuffer(NIOServerCnxn.java:153)
[junit4:junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.sendResponse(NIOServerCnxn.java:1076)
[junit4:junit4] 2> at org.apache.zookeeper.server.FinalRequestProcessor.processRequest(FinalRequestProcessor.java:170)
[junit4:junit4] 2> at org.apache.zookeeper.server.SyncRequestProcessor.run(SyncRequestProcessor.java:138)
[junit4:junit4] 2>
[junit4:junit4] 2> 10576 T65 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server localhost.localdomain/127.0.0.1:45582. Will not attempt to authenticate using SASL (access denied (javax.security.auth.AuthPermission getLoginConfiguration))
[junit4:junit4] 2> 10576 T65 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:45582, initiating session
[junit4:junit4] 2> 10576 T55 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:37010
[junit4:junit4] 2> 10579 T55 oazs.ZooKeeperServer.processConnectRequest Client attempting to renew session 0x13c2d2307290003 at /127.0.0.1:37010
[junit4:junit4] 2> 10579 T55 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c2d2307290003 with negotiated timeout 10000 for client /127.0.0.1:37010
[junit4:junit4] 2> 10579 T65 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server localhost.localdomain/127.0.0.1:45582, sessionid = 0x13c2d2307290003, negotiated timeout = 10000
[junit4:junit4] 2> 10580 T66 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6e056e name:ZooKeeperConnection Watcher:127.0.0.1:45582/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 10580 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x2b zxid:0x29 txntype:-1 reqpath:n/a Error Path:/solr/overseer/collection-queue-work Error:KeeperErrorCode = NodeExists for /solr/overseer/collection-queue-work
[junit4:junit4] 2> 10581 T67 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4:junit4] 2> 10583 T53 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/
[junit4:junit4] 2> 10583 T68 oasc.SolrException.log SEVERE :org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode = NodeExists for /overseer/collection-queue-work
[junit4:junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:119)
[junit4:junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4:junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4:junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:219)
[junit4:junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:216)
[junit4:junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
[junit4:junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:216)
[junit4:junit4] 2> at org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:277)
[junit4:junit4] 2> at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:100)
[junit4:junit4] 2> at java.lang.Thread.run(Thread.java:662)
[junit4:junit4] 2>
[junit4:junit4] 2> 10585 T53 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@89dd
[junit4:junit4] 2> 10586 T53 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 10586 T68 ccr.RandomizedRunner$QueueUncaughtExceptionsHandler.uncaughtException WARNING Uncaught exception in thread: Thread[Overseer-88995721107800067-188.138.97.18:null_solr-n_0000000000,5,Overseer collection creation process.] org.apache.solr.common.cloud.ZooKeeperException:
[junit4:junit4] 2> at __randomizedtesting.SeedInfo.seed([C4A85CE73DDC2252]:0)
[junit4:junit4] 2> at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:131)
[junit4:junit4] 2> at java.lang.Thread.run(Thread.java:662)
[junit4:junit4] 2> Caused by: org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode = NodeExists for /overseer/collection-queue-work
[junit4:junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:119)
[junit4:junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4:junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4:junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:219)
[junit4:junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:216)
[junit4:junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
[junit4:junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:216)
[junit4:junit4] 2> at org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:277)
[junit4:junit4] 2> at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:100)
[junit4:junit4] 2> ... 1 more
[junit4:junit4] 2>
[junit4:junit4] 2> 10587 T53 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540 forceNew:false
[junit4:junit4] 2> 10587 T53 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 10588 T53 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index/
[junit4:junit4] 2> 10588 T53 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index' doesn't exist. Creating new index...
[junit4:junit4] 2> 10589 T53 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index forceNew:false
[junit4:junit4] 2> 10591 T53 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 10591 T53 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 10592 T53 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 10593 T53 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter
[junit4:junit4] 2> 10595 T53 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4:junit4] 2> 10596 T53 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields"
[junit4:junit4] 2> 10597 T53 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4:junit4] 2> 10598 T53 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields"
[junit4:junit4] 2> 10599 T53 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4:junit4] 2> 10599 T53 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler
[junit4:junit4] 2> 10600 T53 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 10601 T53 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler
[junit4:junit4] 2> 10602 T53 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 10603 T53 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler
[junit4:junit4] 2> 10604 T53 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler
[junit4:junit4] 2> 10605 T53 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers
[junit4:junit4] 2> 10606 T53 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler
[junit4:junit4] 2> 10606 T53 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler
[junit4:junit4] 2> 10607 T53 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler
[junit4:junit4] 2> 10608 T53 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 10609 T53 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 10610 T53 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 10611 T53 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 10612 T53 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 10613 T53 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 10614 T53 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 10615 T53 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 10616 T53 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler
[junit4:junit4] 2> 10617 T53 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler
[junit4:junit4] 2> 10618 T53 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 2> 10621 T53 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 10624 T53 oasc.SolrCore.initDeprecatedSupport WARNING solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler.
[junit4:junit4] 2> 10627 T53 oasc.SolrCore.initDeprecatedSupport WARNING adding ShowFileRequestHandler with hidden files: [THROW.ERROR.ON.ADD.UPDATEPROCESSOR.JS, SOLRCONFIG-HIGHLIGHT.XML, SCHEMA-REQUIRED-FIELDS.XML, SCHEMA-REPLICATION2.XML, TRIVIAL.UPDATEPROCESSOR1.JS, BAD-SCHEMA-DUP-DYNAMICFIELD.XML, SCHEMA-MINIMAL.XML, SOLRCONFIG-CACHING.XML, SCHEMA-POSTINGSHIGHLIGHT.XML, SOLRCONFIG-REPEATER.XML, BAD-SCHEMA-NONTEXT-ANALYZER.XML, CURRENCY.XML, SOLRCONFIG-MERGEPOLICY.XML, SOLRCONFIG-TLOG.XML, SOLRCONFIG-MASTER.XML, SOLRCONFIG-COMPONENTS-NAME.XML, BAD-SCHEMA-UNIQUEKEY-MULTIVALUED.XML, SCHEMA11.XML, SOLRCONFIG-BASIC.XML, DA_COMPOUNDDICTIONARY.TXT, MISSLEADING.EXTENSION.UPDATEPROCESSOR.JS.TXT, SCHEMA-COPYFIELD-TEST.XML, SOLRCONFIG-SLAVE.XML, ELEVATE.XML, SOLRCONFIG-PROPINJECT-INDEXDEFAULT.XML, TRIVIAL.UPDATEPROCESSOR0.JS, BAD-SOLRCONFIG-BOGUS-SCRIPTENGINE-NAME.XML, SCHEMA-CHARFILTERS.XML, SCHEMA-IB.XML, SOLRCONFIG-QUERYSENDER.XML, SCHEMA-REPLICATION1.XML, SOLRCONFIG-SNIPPET-PROCESSOR.XML, DA_UTF8.XML, CONDITIONAL.UPDATEPROCESSOR.JS, MISSING.FUNCTIONS.UPDATEPROCESSOR.JS, HYPHENATION.DTD, SOLRCONFIG-ENABLEPLUGIN.XML, SCHEMA-PHRASESUGGEST.XML, STEMDICT.TXT, HUNSPELL-TEST.AFF, SCHEMA-SNIPPET-TYPE.XML, STOPTYPES-1.TXT, STOPWORDSWRONGENCODING.TXT, SCHEMA-NUMERIC.XML, SOLRCONFIG-TRANSFORMERS.XML, SOLRCONFIG-PROPINJECT.XML, BAD-SCHEMA-NOT-INDEXED-BUT-TF.XML, SOLRCONFIG-SIMPLELOCK.XML, WDFTYPES.TXT, SCHEMA-REVERSED.XML, STOPTYPES-2.TXT, BAD-SCHEMA-CURRENCY-FT-MULTIVALUED.XML, SOLRCONFIG-SPELLCHECKCOMPONENT.XML, BAD-SCHEMA-CURRENCY-MULTIVALUED.XML, SOLRCONFIG-PHRASESUGGEST.XML, SCHEMA-DFR.XML, BAD-SCHEMA-NOT-INDEXED-BUT-POS.XML, KEEP-1.TXT, OPEN-EXCHANGE-RATES.JSON, SCHEMA-SPATIAL.XML, STOPWITHBOM.TXT, SCHEMA-BINARYFIELD.XML, SOLRCONFIG-POSTINGSHIGHLIGHT.XML, SOLRCONFIG-SPELLCHECKER.XML, SOLRCONFIG-UPDATE-PROCESSOR-CHAINS.XML, BAD-SCHEMA-OMIT-TF-BUT-NOT-POS.XML, BAD-SCHEMA-DUP-FIELDTYPE.XML, SCHEMA-XINCLUDE.XML, SOLRCONFIG-MASTER1.XML, SCHEMA-BEHAVIOR.XML, SYNONYMS.TXT, BAD-SCHEMA-CURRENCY-DYNAMIC-MULTIVALUED.XML, SCHEMA_CODEC.XML, SCHEMA.XML, SOLRCONFIG-SOLR-749.XML, SOLRCONFIG-MASTER1-KEEPONEBACKUP.XML, SCHEMA-EFF.XML, SOLRCONFIG-FUNCTIONQUERY.XML, STOP-2.TXT, SCHEMA-LMDIRICHLET.XML, SOLRCONFIG-TERMINDEX.XML, SOLRCONFIG-ELEVATE.XML, SCHEMA-FOLDING.XML, STOPWORDS.TXT, SCHEMA-STOP-KEEP.XML, FUZZYSUGGEST.TXT, BAD-SCHEMA-NOT-INDEXED-BUT-NORMS.XML, SOLRCONFIG-SOLCOREPROPERTIES.XML, STOP-1.TXT, SOLRCONFIG-MASTER2.XML, SCHEMA-SPELLCHECKER.XML, SOLRCONFIG-RESPONSE-LOG-COMPONENT.XML, SOLRCONFIG-LAZYWRITER.XML, SCHEMA-LUCENEMATCHVERSION.XML, FRENCHARTICLES.TXT, BAD-MP-SOLRCONFIG.XML, SCHEMA15.XML, SOLRCONFIG-REQHANDLER.INCL, SCHEMASURROUND.XML, SCHEMA-COLLATEFILTER.XML, SOLRCONFIG-MASTER3.XML, HUNSPELL-TEST.DIC, SOLRCONFIG-XINCLUDE.XML, BAD-SCHEMA-CODEC-GLOBAL-VS-FT-MISMATCH.XML, SOLRCONFIG-DELPOLICY1.XML, SOLRCONFIG-SLAVE1.XML, SCHEMA-SIM.XML, SCHEMA-SNIPPET-FIELD.XML, SCHEMA-COLLATE.XML, STOP-SNOWBALL.TXT, BAD-SCHEMA-SIM-GLOBAL-VS-FT-MISMATCH.XML, PROTWORDS.TXT, SCHEMA-TRIE.XML, SOLRCONFIG_CODEC.XML, SCHEMA-SYNONYM-TOKENIZER.XML, BAD-SOLRCONFIG-INVALID-SCRIPTFILE.XML, JASUGGEST.TXT, SCHEMA-TFIDF.XML, SOLRCONFIG-SCRIPT-UPDATEPROCESSOR.XML, SCHEMA-LMJELINEKMERCER.XML, PHRASESUGGEST.TXT, BAD-SOLRCONFIG-MISSING-SCRIPTFILE.XML, SOLRCONFIG-BASIC-LUCENEVERSION31.XML, BAD-SCHEMA-UNIQUEKEY-USES-DEFAULT.XML, OLD_SYNONYMS.TXT, SOLRCONFIG-DELPOLICY2.XML, XSLT, SOLRCONFIG-NATIVELOCK.XML, BAD-SCHEMA-DUP-FIELD.XML, SOLRCONFIG-NOCACHE.XML, SCHEMA-BM25.XML, ADDFIELDS.UPDATEPROCESSOR.JS, SOLRCONFIG-ALTDIRECTORY.XML, SOLRCONFIG-QUERYSENDER-NOQUERY.XML, COMPOUNDDICTIONARY.TXT, SOLRCONFIG_PERF.XML, SOLRCONFIG-INDEXCONFIG.XML, BAD-SCHEMA-ANALYZER-CLASS-AND-NESTED.XML, SCHEMA-NOT-REQUIRED-UNIQUE-KEY.XML, KEEP-2.TXT, BAD-SCHEMA-UNIQUEKEY-IS-COPYFIELD-DEST.XML, SCHEMA12.XML, MAPPING-ISOLATIN1ACCENT.TXT, BAD_SOLRCONFIG.XML, BAD-SCHEMA-EXTERNAL-FILEFIELD.XML]
[junit4:junit4] 2> 10631 T53 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 10631 T53 oass.SolrIndexSearcher.<init> Opening Searcher@19fc4e main
[junit4:junit4] 2> 10632 T53 oasu.CommitTracker.<init> Hard AutoCommit: disabled
[junit4:junit4] 2> 10633 T53 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 10633 T53 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4] 2> 10701 T53 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
[junit4:junit4] 2> 10727 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@19fc4e main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 10736 T53 oasc.ZkController.publish publishing core=collection1 state=down
[junit4:junit4] 2> 10737 T53 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 10738 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x30 zxid:0x2a txntype:-1 reqpath:n/a Error Path:/solr/overseer/queue Error:KeeperErrorCode = NoNode for /solr/overseer/queue
[junit4:junit4] 2> 12086 T67 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 12088 T67 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=null message={
[junit4:junit4] 2> "operation":"state",
[junit4:junit4] 2> "numShards":null,
[junit4:junit4] 2> "shard":null,
[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":"188.138.97.18:null_solr",
[junit4:junit4] 2> "base_url":"http://188.138.97.18:null/solr"}
[junit4:junit4] 2> 12090 T67 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1
[junit4:junit4] 2> 12096 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x38 zxid:0x2d txntype:-1 reqpath:n/a Error Path:/solr/overseer/queue-work Error:KeeperErrorCode = NoNode for /solr/overseer/queue-work
[junit4:junit4] 2> 12108 T66 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 12741 T53 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> 12741 T53 oasc.ZkController.register Register replica - core:collection1 address:http://188.138.97.18:null/solr collection:collection1 shard:shard1
[junit4:junit4] 2> 12752 T53 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=10000&maxConnectionsPerHost=20&connTimeout=30000&socketTimeout=30000&retry=false
[junit4:junit4] 2> 12759 T53 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard1/election
[junit4:junit4] 2> 12767 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:delete cxid:0x52 zxid:0x37 txntype:-1 reqpath:n/a Error Path:/solr/collections/collection1/leaders Error:KeeperErrorCode = NoNode for /solr/collections/collection1/leaders
[junit4:junit4] 2> 12768 T53 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process.
[junit4:junit4] 2> 12768 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x53 zxid:0x38 txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 12771 T53 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue.
[junit4:junit4] 2> 12771 T53 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync
[junit4:junit4] 2> 12773 T53 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: http://188.138.97.18:null/solr/collection1/
[junit4:junit4] 2> 12773 T53 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard1
[junit4:junit4] 2> 12777 T58 oazs.PrepRequestProcessor.pRequest Got user-level KeeperException when processing sessionid:0x13c2d2307290003 type:create cxid:0x5d zxid:0x3c txntype:-1 reqpath:n/a Error Path:/solr/overseer Error:KeeperErrorCode = NodeExists for /solr/overseer
[junit4:junit4] 2> 13615 T67 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 13697 T66 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 13732 T53 oasc.ZkController.register We are http://188.138.97.18:null/solr/collection1/ and leader is http://188.138.97.18:null/solr/collection1/
[junit4:junit4] 2> 13733 T53 oasc.ZkController.checkRecovery WARNING Skipping recovery according to sys prop solrcloud.skip.autorecovery
[junit4:junit4] 2> 13733 T53 oasc.ZkController.publish publishing core=collection1 state=active
[junit4:junit4] 2> 13733 T53 oasc.ZkController.publish numShards not found on descriptor - reading it from system property
[junit4:junit4] 2> 13737 T53 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 13740 T53 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4:junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4:junit4] 2> 13745 T53 oas.SolrTestCaseJ4.setUp ###Starting testBasic
[junit4:junit4] 2> 13745 T53 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 13746 T53 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 13747 T53 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> ASYNC NEW_CORE C2 name=collection1 org.apache.solr.core.SolrCore@141d19 url=http://188.138.97.18:null/solr/collection1 node=188.138.97.18:null_solr C2_STATE=coll:collection1 core:collection1 props:{shard=null, roles=null, state=down, core=collection1, collection=collection1, node_name=188.138.97.18:null_solr, base_url=http://188.138.97.18:null/solr, leader=true}
[junit4:junit4] 2> 13748 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=qlkciyopsbgzyvkylsjhchghjrdf&qt=standard&rows=20&version=2.2} hits=0 status=0 QTime=1
[junit4:junit4] 2> 13786 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {delete=[42]} 0 28
[junit4:junit4] 2> 13795 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[42]} 0 2
[junit4:junit4] 2> 13801 T53 C2 Pnull oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 13804 T53 C2 Pnull oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_2,generation=2,filenames=[_0.fnm, _0_Lucene41_0.doc, _0_Lucene41_0.pos, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene41_0.tim, _0.fdt, _0_Lucene41_0.tip]
[junit4:junit4] 2> 13805 T53 C2 Pnull oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0.fnm, _0_Lucene41_0.doc, _0_Lucene41_0.pos, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene41_0.tim, _0.fdt, _0_Lucene41_0.tip]
[junit4:junit4] 2> 13805 T53 C2 Pnull oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 13807 T53 C2 Pnull oass.SolrIndexSearcher.<init> Opening Searcher@14920f8 main
[junit4:junit4] 2> 13808 T53 C2 Pnull oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 13810 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@14920f8 main{StandardDirectoryReader(segments_2:3 _0(4.1):C1)}
[junit4:junit4] 2> 13811 T69 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 13811 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {commit=} 0 10
[junit4:junit4] 2> 13818 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:42+AND+val_s:aa\;bb&qt=standard&rows=20&version=2.2} hits=1 status=0 QTime=4
[junit4:junit4] 2> 13824 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:42+AND+val_s:"aa;bb"&qt=standard&rows=20&version=2.2} hits=1 status=0 QTime=2
[junit4:junit4] 2> 13828 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:42+AND+val_s:aa&qt=standard&rows=20&version=2.2} hits=0 status=0 QTime=1
[junit4:junit4] 2> 13841 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {delete=[42]} 0 0
[junit4:junit4] 2> 13864 T53 C2 Pnull oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 13866 T53 C2 Pnull oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_2,generation=2,filenames=[_0.fnm, _0_Lucene41_0.doc, _0_Lucene41_0.pos, _0_nrm.cfe, segments_2, _0.fdx, _0_nrm.cfs, _0.si, _0_Lucene41_0.tim, _0.fdt, _0_Lucene41_0.tip]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_3,generation=3,filenames=[segments_3]
[junit4:junit4] 2> 13867 T53 C2 Pnull oasc.SolrDeletionPolicy.updateCommits newest commit = 3[segments_3]
[junit4:junit4] 2> 13868 T53 C2 Pnull oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 13869 T53 C2 Pnull oass.SolrIndexSearcher.<init> Opening Searcher@14e430c main
[junit4:junit4] 2> 13870 T53 C2 Pnull oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 13873 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@14e430c main{StandardDirectoryReader(segments_3:5)}
[junit4:junit4] 2> 13874 T69 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 13875 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {commit=} 0 11
[junit4:junit4] 2> 13877 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:42&qt=standard&rows=20&version=2.2} hits=0 status=0 QTime=0
[junit4:junit4] 2> 13893 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[42]} 0 2
[junit4:junit4] 2> 13910 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[42]} 0 2
[junit4:junit4] 2> 13925 T53 C2 Pnull oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 13928 T53 C2 Pnull oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_3,generation=3,filenames=[segments_3]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_4,generation=4,filenames=[_1.fdx, _1_Lucene41_0.pos, _1_nrm.cfs, _1_Lucene41_0.doc, _1.fdt, _1.si, _1_Lucene41_0.tim, _1_Lucene41_0.tip, _1_1.del, _1.fnm, _1_nrm.cfe, segments_4]
[junit4:junit4] 2> 13929 T53 C2 Pnull oasc.SolrDeletionPolicy.updateCommits newest commit = 4[_1.fdx, _1_Lucene41_0.pos, _1_nrm.cfs, _1_Lucene41_0.doc, _1.fdt, _1.si, _1_Lucene41_0.tim, _1_Lucene41_0.tip, _1_1.del, _1.fnm, _1_nrm.cfe, segments_4]
[junit4:junit4] 2> 13930 T53 C2 Pnull oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 13932 T53 C2 Pnull oass.SolrIndexSearcher.<init> Opening Searcher@1995c9a main
[junit4:junit4] 2> 13933 T53 C2 Pnull oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 13936 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1995c9a main{StandardDirectoryReader(segments_4:7 _1(4.1):C2/1)}
[junit4:junit4] 2> 13937 T69 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 13937 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {commit=} 0 12
[junit4:junit4] 2> 13941 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:42&qt=standard&rows=20&version=2.2} hits=1 status=0 QTime=1
[junit4:junit4] 2> 13953 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[42]} 0 2
[junit4:junit4] 2> 13961 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[42]} 0 1
[junit4:junit4] 2> 13971 T53 C2 Pnull oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 13976 T53 C2 Pnull oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_4,generation=4,filenames=[_1.fdx, _1_Lucene41_0.pos, _1_nrm.cfs, _1_Lucene41_0.doc, _1.fdt, _1.si, _1_Lucene41_0.tim, _1_Lucene41_0.tip, _1_1.del, _1.fnm, _1_nrm.cfe, segments_4]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_5,generation=5,filenames=[_2.si, _2_Lucene41_0.pos, _2_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2_nrm.cfs, segments_5, _2.fdx, _2_1.del, _2.fnm]
[junit4:junit4] 2> 13976 T53 C2 Pnull oasc.SolrDeletionPolicy.updateCommits newest commit = 5[_2.si, _2_Lucene41_0.pos, _2_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2_nrm.cfs, segments_5, _2.fdx, _2_1.del, _2.fnm]
[junit4:junit4] 2> 13977 T53 C2 Pnull oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 13979 T53 C2 Pnull oass.SolrIndexSearcher.<init> Opening Searcher@1e7ce87 main
[junit4:junit4] 2> 13979 T53 C2 Pnull oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 13982 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e7ce87 main{StandardDirectoryReader(segments_5:11 _2(4.1):C2/1)}
[junit4:junit4] 2> 13982 T69 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 13983 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {commit=} 0 12
[junit4:junit4] 2> 13985 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:42&qt=standard&rows=20&version=2.2} hits=1 status=0 QTime=0
[junit4:junit4] 2> 13996 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[101]} 0 2
[junit4:junit4] 2> 14004 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[101]} 0 1
[junit4:junit4] 2> 14012 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[105]} 0 1
[junit4:junit4] 2> 14020 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[102]} 0 1
[junit4:junit4] 2> 14028 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[103]} 0 1
[junit4:junit4] 2> 14038 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {add=[101]} 0 1
[junit4:junit4] 2> 14045 T53 C2 Pnull oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 14050 T53 C2 Pnull oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_5,generation=5,filenames=[_2.si, _2_Lucene41_0.pos, _2_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2_nrm.cfs, segments_5, _2.fdx, _2_1.del, _2.fnm]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_6,generation=6,filenames=[_2_Lucene41_0.pos, _2.si, _3_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _3.fdt, _3.fnm, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2.fdx, _3_1.del, _2.fnm, _3.fdx, _3_nrm.cfs, _2_nrm.cfe, _3_Lucene41_0.doc, _3_Lucene41_0.pos, _3_Lucene41_0.tip, _3.si, _3_Lucene41_0.tim, _2_nrm.cfs, segments_6, _2_1.del]
[junit4:junit4] 2> 14050 T53 C2 Pnull oasc.SolrDeletionPolicy.updateCommits newest commit = 6[_2_Lucene41_0.pos, _2.si, _3_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _3.fdt, _3.fnm, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2.fdx, _3_1.del, _2.fnm, _3.fdx, _3_nrm.cfs, _2_nrm.cfe, _3_Lucene41_0.doc, _3_Lucene41_0.pos, _3_Lucene41_0.tip, _3.si, _3_Lucene41_0.tim, _2_nrm.cfs, segments_6, _2_1.del]
[junit4:junit4] 2> 14051 T53 C2 Pnull oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 14053 T53 C2 Pnull oass.SolrIndexSearcher.<init> Opening Searcher@17d26fc main
[junit4:junit4] 2> 14054 T53 C2 Pnull oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 14056 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@17d26fc main{StandardDirectoryReader(segments_6:13 _2(4.1):C2/1 _3(4.1):C6/2)}
[junit4:junit4] 2> 14057 T69 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 14057 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {commit=} 0 12
[junit4:junit4] 2> 14059 T53 oazs.ZooKeeperServer.shutdown shutting down
[junit4:junit4] 2> 14059 T53 oazs.SessionTrackerImpl.shutdown Shutting down
[junit4:junit4] 2> 14060 T53 oazs.PrepRequestProcessor.shutdown Shutting down
[junit4:junit4] 2> 14060 T58 oazs.PrepRequestProcessor.run PrepRequestProcessor exited loop!
[junit4:junit4] 2> 14060 T53 oazs.SyncRequestProcessor.shutdown Shutting down
[junit4:junit4] 2> 14061 T57 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4] 2> 14061 T53 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4] 2> 14063 T53 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:45582 45582
[junit4:junit4] 2> 14086 T53 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:37010 which had sessionid 0x13c2d2307290003
[junit4:junit4] 2> 14087 T55 oazs.NIOServerCnxnFactory.run NIOServerCnxn factory exited run method
[junit4:junit4] 2> 14087 T65 oaz.ClientCnxn$SendThread.run Unable to read additional data from server sessionid 0x13c2d2307290003, likely server has closed socket, closing socket connection and attempting reconnect
[junit4:junit4] 2> 14087 T53 oazs.ZooKeeperServer.shutdown shutting down
[junit4:junit4] 2> 14087 T53 oazs.SessionTrackerImpl.shutdown Shutting down
[junit4:junit4] 2> 14088 T53 oazs.PrepRequestProcessor.shutdown Shutting down
[junit4:junit4] 2> 14088 T53 oazs.SyncRequestProcessor.shutdown Shutting down
[junit4:junit4] 2> 14088 T53 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4] 2> 14187 T66 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6e056e name:ZooKeeperConnection Watcher:127.0.0.1:45582/solr got event WatchedEvent state:Disconnected type:None path:null path:null type:None
[junit4:junit4] 2> 14188 T66 oascc.ConnectionManager.process zkClient has disconnected
[junit4:junit4] 2> 14389 T53 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4] 2> 14390 T70 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4:junit4] 2> 14390 T70 oazs.ZooKeeperServer.setTickTime tickTime set to 1000
[junit4:junit4] 2> 14390 T70 oazs.ZooKeeperServer.setMinSessionTimeout minSessionTimeout set to -1
[junit4:junit4] 2> 14390 T70 oazs.ZooKeeperServer.setMaxSessionTimeout maxSessionTimeout set to -1
[junit4:junit4] 2> 14391 T70 oazs.NIOServerCnxnFactory.configure binding to port 0.0.0.0/0.0.0.0:45582
[junit4:junit4] 2> 14392 T70 oazsp.FileSnap.deserialize Reading snapshot /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/zookeeper/server1/data/version-2/snapshot.0
[junit4:junit4] 2> 14399 T70 oazsp.FileTxnSnapLog.save Snapshotting: 0x45 to /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/zookeeper/server1/data/version-2/snapshot.45
[junit4:junit4] 2> 14462 T56 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
[junit4:junit4] 2> 14490 T53 oasc.ZkTestServer.run start zk server on port:45582
[junit4:junit4] 2> 14796 T53 C2 Pnull REQ [collection1] webapp=null path=null params={q=id:[100+TO+110]&rows=2147483647} hits=4 status=0 QTime=6
[junit4:junit4] 2> 14800 T53 C2 Pnull REQ [collection1] webapp=null path=null params={q=id:[100+TO+111]&rows=1147483647} hits=4 status=0 QTime=0
[junit4:junit4] 2> 14804 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:[100+TO+110]&qt=standard&rows=20&version=2.2} hits=4 status=0 QTime=1
[junit4:junit4] 2> 14811 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {delete=[102]} 0 0
[junit4:junit4] 2> 14818 T53 C2 Pnull oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 14821 T53 C2 Pnull oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_6,generation=6,filenames=[_2_Lucene41_0.pos, _2.si, _3_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _3.fdt, _3.fnm, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2.fdx, _3_1.del, _2.fnm, _3.fdx, _3_nrm.cfs, _2_nrm.cfe, _3_Lucene41_0.doc, _3_Lucene41_0.pos, _3_Lucene41_0.tip, _3.si, _3_Lucene41_0.tim, _2_nrm.cfs, segments_6, _2_1.del]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_7,generation=7,filenames=[_2_Lucene41_0.pos, _2.si, _3_nrm.cfe, _2_Lucene41_0.tim, _3_2.del, _2.fdt, _3.fdt, _3.fnm, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2.fdx, _2.fnm, _3.fdx, _3_nrm.cfs, segments_7, _2_nrm.cfe, _3_Lucene41_0.doc, _3_Lucene41_0.pos, _3_Lucene41_0.tip, _3.si, _3_Lucene41_0.tim, _2_nrm.cfs, _2_1.del]
[junit4:junit4] 2> 14821 T53 C2 Pnull oasc.SolrDeletionPolicy.updateCommits newest commit = 7[_2_Lucene41_0.pos, _2.si, _3_nrm.cfe, _2_Lucene41_0.tim, _3_2.del, _2.fdt, _3.fdt, _3.fnm, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2.fdx, _2.fnm, _3.fdx, _3_nrm.cfs, segments_7, _2_nrm.cfe, _3_Lucene41_0.doc, _3_Lucene41_0.pos, _3_Lucene41_0.tip, _3.si, _3_Lucene41_0.tim, _2_nrm.cfs, _2_1.del]
[junit4:junit4] 2> 14822 T53 C2 Pnull oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 14823 T53 C2 Pnull oass.SolrIndexSearcher.<init> Opening Searcher@1bf9980 main
[junit4:junit4] 2> 14823 T53 C2 Pnull oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 14826 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1bf9980 main{StandardDirectoryReader(segments_7:14 _2(4.1):C2/1 _3(4.1):C6/3)}
[junit4:junit4] 2> 14826 T69 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 14827 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {commit=} 0 9
[junit4:junit4] 2> 14829 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:[100+TO+110]&qt=standard&rows=20&version=2.2} hits=3 status=0 QTime=0
[junit4:junit4] 2> 14840 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {delete=[105]} 0 0
[junit4:junit4] 2> 14847 T53 C2 Pnull oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 14850 T53 C2 Pnull oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_7,generation=7,filenames=[_2_Lucene41_0.pos, _2.si, _3_nrm.cfe, _2_Lucene41_0.tim, _3_2.del, _2.fdt, _3.fdt, _3.fnm, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2.fdx, _2.fnm, _3.fdx, _3_nrm.cfs, segments_7, _2_nrm.cfe, _3_Lucene41_0.doc, _3_Lucene41_0.pos, _3_Lucene41_0.tip, _3.si, _3_Lucene41_0.tim, _2_nrm.cfs, _2_1.del]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_8,generation=8,filenames=[_2_Lucene41_0.pos, _2.si, _3_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _3.fdt, _3.fnm, _2_Lucene41_0.doc, _3_3.del, _2_Lucene41_0.tip, _2.fdx, _2.fnm, _3.fdx, _3_nrm.cfs, _2_nrm.cfe, segments_8, _3_Lucene41_0.doc, _3_Lucene41_0.pos, _3_Lucene41_0.tip, _3.si, _3_Lucene41_0.tim, _2_nrm.cfs, _2_1.del]
[junit4:junit4] 2> 14850 T53 C2 Pnull oasc.SolrDeletionPolicy.updateCommits newest commit = 8[_2_Lucene41_0.pos, _2.si, _3_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _3.fdt, _3.fnm, _2_Lucene41_0.doc, _3_3.del, _2_Lucene41_0.tip, _2.fdx, _2.fnm, _3.fdx, _3_nrm.cfs, _2_nrm.cfe, segments_8, _3_Lucene41_0.doc, _3_Lucene41_0.pos, _3_Lucene41_0.tip, _3.si, _3_Lucene41_0.tim, _2_nrm.cfs, _2_1.del]
[junit4:junit4] 2> 14851 T53 C2 Pnull oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 14852 T53 C2 Pnull oass.SolrIndexSearcher.<init> Opening Searcher@1cc5af0 main
[junit4:junit4] 2> 14852 T53 C2 Pnull oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 14854 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1cc5af0 main{StandardDirectoryReader(segments_8:15 _2(4.1):C2/1 _3(4.1):C6/4)}
[junit4:junit4] 2> 14855 T69 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 14855 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {commit=} 0 8
[junit4:junit4] 2> 14858 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:[100+TO+110]&qt=standard&rows=20&version=2.2} hits=2 status=0 QTime=1
[junit4:junit4] 2> 14866 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {deleteByQuery=id:[100 TO 110]} 0 2
[junit4:junit4] 2> 14872 T53 C2 Pnull oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false}
[junit4:junit4] 2> 14875 T53 C2 Pnull oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_8,generation=8,filenames=[_2_Lucene41_0.pos, _2.si, _3_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _3.fdt, _3.fnm, _2_Lucene41_0.doc, _3_3.del, _2_Lucene41_0.tip, _2.fdx, _2.fnm, _3.fdx, _3_nrm.cfs, _2_nrm.cfe, segments_8, _3_Lucene41_0.doc, _3_Lucene41_0.pos, _3_Lucene41_0.tip, _3.si, _3_Lucene41_0.tim, _2_nrm.cfs, _2_1.del]
[junit4:junit4] 2> commit{dir=RateLimitedDirectoryWrapper(BaseDirectoryWrapper(org.apache.lucene.store.RAMDirectory@163de4e lockFactory=org.apache.lucene.store.NativeFSLockFactory@65d588)),segFN=segments_9,generation=9,filenames=[_2.si, _2_Lucene41_0.pos, segments_9, _2_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2_nrm.cfs, _2.fdx, _2_1.del, _2.fnm]
[junit4:junit4] 2> 14875 T53 C2 Pnull oasc.SolrDeletionPolicy.updateCommits newest commit = 9[_2.si, _2_Lucene41_0.pos, segments_9, _2_nrm.cfe, _2_Lucene41_0.tim, _2.fdt, _2_Lucene41_0.doc, _2_Lucene41_0.tip, _2_nrm.cfs, _2.fdx, _2_1.del, _2.fnm]
[junit4:junit4] 2> 14876 T53 C2 Pnull oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 14877 T53 C2 Pnull oass.SolrIndexSearcher.<init> Opening Searcher@1b56bda main
[junit4:junit4] 2> 14877 T53 C2 Pnull oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 14879 T69 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b56bda main{StandardDirectoryReader(segments_9:17 _2(4.1):C2/1)}
[junit4:junit4] 2> 14880 T69 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 14880 T53 C2 Pnull UPDATE [collection1] webapp=null path=null params={} {commit=} 0 8
[junit4:junit4] 2> 14883 T53 C2 Pnull REQ [collection1] webapp=null path=null params={start=0&q=id:[100+TO+110]&qt=standard&rows=20&version=2.2} hits=0 status=0 QTime=1
[junit4:junit4] 2> 16053 T65 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server localhost.localdomain/127.0.0.1:45582. Will not attempt to authenticate using SASL (access denied (javax.security.auth.AuthPermission getLoginConfiguration))
[junit4:junit4] 2> 16053 T65 oaz.ClientCnxn$SendThread.primeConnection Socket connection established to localhost.localdomain/127.0.0.1:45582, initiating session
[junit4:junit4] 2> 16054 T71 oazs.NIOServerCnxnFactory.run Accepted socket connection from /127.0.0.1:37011
[junit4:junit4] 2> 16054 T71 oazs.ZooKeeperServer.processConnectRequest Client attempting to renew session 0x13c2d2307290003 at /127.0.0.1:37011
[junit4:junit4] 2> 16055 T71 oazs.ZooKeeperServer.finishSessionInit Established session 0x13c2d2307290003 with negotiated timeout 10000 for client /127.0.0.1:37011
[junit4:junit4] 2> 16055 T65 oaz.ClientCnxn$SendThread.onConnected Session establishment complete on server localhost.localdomain/127.0.0.1:45582, sessionid = 0x13c2d2307290003, negotiated timeout = 10000
[junit4:junit4] 2> 16055 T66 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6e056e name:ZooKeeperConnection Watcher:127.0.0.1:45582/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4:junit4] 2> 16056 T73 oazsp.FileTxnLog.append Creating new log file: log.46
[junit4:junit4] 2> 16077 T53 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1
[junit4:junit4] 2> 16078 T53 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1
[junit4:junit4] 2> 16079 T53 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4:junit4] 2> 16079 T53 oasc.ZkController.readConfigName Load collection config from:/collections/collection1
[junit4:junit4] 2> 16079 T67 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4:junit4] 2> 16081 T67 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":"188.138.97.18:null_solr",
[junit4:junit4] 2> "base_url":"http://188.138.97.18:null/solr"}
[junit4:junit4] 2> 16081 T53 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/'
[junit4:junit4] 2> 16082 T53 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader
[junit4:junit4] 2> 16083 T53 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader
[junit4:junit4] 2> 16085 T66 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1)
[junit4:junit4] 2> 16123 T53 oasc.SolrException.log SEVERE Exception during parsing file: solrconfig.xml:org.xml.sax.SAXParseException: Premature end of file.
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:195)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.fatalError(ErrorHandlerWrapper.java:174)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:388)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLScanner.reportFatalError(XMLScanner.java:1427)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl$PrologDriver.next(XMLDocumentScannerImpl.java:1056)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(XMLDocumentScannerImpl.java:647)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.next(XMLNSDocumentScannerImpl.java:140)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(XMLDocumentFragmentScannerImpl.java:511)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:808)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:737)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:119)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(DOMParser.java:232)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(DocumentBuilderImpl.java:284)
[junit4:junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:121)
[junit4:junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:73)
[junit4:junit4] 2> at org.apache.solr.core.SolrConfig.<init>(SolrConfig.java:117)
[junit4:junit4] 2> at org.apache.solr.core.SolrCore.reload(SolrCore.java:392)
[junit4:junit4] 2> at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1169)
[junit4:junit4] 2> at org.apache.solr.cloud.BasicZkTest.testBasic(BasicZkTest.java:160)
[junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit4:junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit4:junit4] 2> at java.lang.reflect.Method.invoke(Method.java:597)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4] 2> at java.lang.Thread.run(Thread.java:662)
[junit4:junit4] 2>
[junit4:junit4] 2> 16124 T53 oasc.CoreContainer.recordAndThrow SEVERE Unable to reload core: collection1 org.xml.sax.SAXParseException: Premature end of file.
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:195)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.fatalError(ErrorHandlerWrapper.java:174)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:388)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLScanner.reportFatalError(XMLScanner.java:1427)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl$PrologDriver.next(XMLDocumentScannerImpl.java:1056)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(XMLDocumentScannerImpl.java:647)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLNSDocumentScannerImpl.next(XMLNSDocumentScannerImpl.java:140)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(XMLDocumentFragmentScannerImpl.java:511)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:808)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:737)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:119)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(DOMParser.java:232)
[junit4:junit4] 2> at com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(DocumentBuilderImpl.java:284)
[junit4:junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:121)
[junit4:junit4] 2> at org.apache.solr.core.Config.<init>(Config.java:73)
[junit4:junit4] 2> at org.apache.solr.core.SolrConfig.<init>(SolrConfig.java:117)
[junit4:junit4] 2> at org.apache.solr.core.SolrCore.reload(SolrCore.java:392)
[junit4:junit4] 2> at org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1169)
[junit4:junit4] 2> at org.apache.solr.cloud.BasicZkTest.testBasic(BasicZkTest.java:160)
[junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
[junit4:junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
[junit4:junit4] 2> at java.lang.reflect.Method.invoke(Method.java:597)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4] 2> at java.lang.Thread.run(Thread.java:662)
[junit4:junit4] 2>
[junit4:junit4] 2> 16126 T53 oas.SolrTestCaseJ4.tearDown ###Ending testBasic
[junit4:junit4] 1> client port:0.0.0.0/0.0.0.0:45582
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=BasicZkTest -Dtests.method=testBasic -Dtests.seed=C4A85CE73DDC2252 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ro_RO -Dtests.timezone=America/Denver -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR 2.46s J1 | BasicZkTest.testBasic <<<
[junit4:junit4] > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=68, name=Overseer-88995721107800067-188.138.97.18:null_solr-n_0000000000, state=RUNNABLE, group=Overseer collection creation process.]
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([C4A85CE73DDC2252:6F5241F2E200A47C]:0)
[junit4:junit4] > Caused by: org.apache.solr.common.cloud.ZooKeeperException:
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([C4A85CE73DDC2252]:0)
[junit4:junit4] > at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:131)
[junit4:junit4] > at java.lang.Thread.run(Thread.java:662)
[junit4:junit4] > Caused by: org.apache.zookeeper.KeeperException$NodeExistsException: KeeperErrorCode = NodeExists for /overseer/collection-queue-work
[junit4:junit4] > at org.apache.zookeeper.KeeperException.create(KeeperException.java:119)
[junit4:junit4] > at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4:junit4] > at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4:junit4] > at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:219)
[junit4:junit4] > at org.apache.solr.common.cloud.SolrZkClient$5.execute(SolrZkClient.java:216)
[junit4:junit4] > at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:65)
[junit4:junit4] > at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:216)
[junit4:junit4] > at org.apache.solr.cloud.DistributedQueue.peek(DistributedQueue.java:277)
[junit4:junit4] > at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:100)
[junit4:junit4] > ... 1 more
[junit4:junit4] 2> 16197 T53 oazs.ZooKeeperServer.shutdown shutting down
[junit4:junit4] 2> 16197 T53 oazs.SessionTrackerImpl.shutdown Shutting down
[junit4:junit4] 2> 16197 T53 oazs.PrepRequestProcessor.shutdown Shutting down
[junit4:junit4] 2> 16197 T74 oazs.PrepRequestProcessor.run PrepRequestProcessor exited loop!
[junit4:junit4] 2> 16197 T53 oazs.SyncRequestProcessor.shutdown Shutting down
[junit4:junit4] 2> 16198 T73 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4] 2> 16198 T53 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4] 2> 16199 T53 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:45582 45582
[junit4:junit4] 2> 16206 T53 oazs.NIOServerCnxn.closeSock Closed socket connection for client /127.0.0.1:37011 which had sessionid 0x13c2d2307290003
[junit4:junit4] 2> 16206 T71 oazs.NIOServerCnxnFactory.run NIOServerCnxn factory exited run method
[junit4:junit4] 2> 16206 T65 oaz.ClientCnxn$SendThread.run Unable to read additional data from server sessionid 0x13c2d2307290003, likely server has closed socket, closing socket connection and attempting reconnect
[junit4:junit4] 2> 16207 T53 oazs.ZooKeeperServer.shutdown shutting down
[junit4:junit4] 2> 16207 T53 oazs.SessionTrackerImpl.shutdown Shutting down
[junit4:junit4] 2> 16207 T53 oazs.PrepRequestProcessor.shutdown Shutting down
[junit4:junit4] 2> 16208 T53 oazs.SyncRequestProcessor.shutdown Shutting down
[junit4:junit4] 2> 16208 T53 oazs.FinalRequestProcessor.shutdown shutdown of request processor complete
[junit4:junit4] 2> 16307 T66 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6e056e name:ZooKeeperConnection Watcher:127.0.0.1:45582/solr got event WatchedEvent state:Disconnected type:None path:null path:null type:None
[junit4:junit4] 2> 16307 T66 oascc.ConnectionManager.process zkClient has disconnected
[junit4:junit4] 2> 16461 T72 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
[junit4:junit4] 2> 17339 T65 oaz.ClientCnxn$SendThread.logStartConnect Opening socket connection to server localhost.localdomain/127.0.0.1:45582. Will not attempt to authenticate using SASL (access denied (javax.security.auth.AuthPermission getLoginConfiguration))
[junit4:junit4] 2> 17340 T65 oaz.ClientCnxn$SendThread.run WARNING Session 0x13c2d2307290003 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.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:350)
[junit4:junit4] 2> at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1068)
[junit4:junit4] 2>
[junit4:junit4] 2> 18208 T53 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 2> 18209 T53 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=6928382
[junit4:junit4] 2> 18209 T53 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@141d19
[junit4:junit4] 2> 18224 T53 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=8,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=11,cumulative_deletesById=4,cumulative_deletesByQuery=1,cumulative_errors=0}
[junit4:junit4] 2> 18224 T53 oasc.SolrCore.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4] 2> 18224 T53 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4] 2> 18225 T53 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4] 2> C2_STATE=coll:collection1 core:collection1 props:{shard=shard1, roles=null, state=active, core=collection1, collection=collection1, node_name=188.138.97.18:null_solr, base_url=http://188.138.97.18:null/solr, leader=true}
[junit4:junit4] 2> 18225 T53 C2 Pnull oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 18226 T53 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4] 2> 18226 T53 oasc.CachingDirectoryFactory.close Releasing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 18227 T53 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 18227 T53 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540/index
[junit4:junit4] 2> 18242 T53 oasc.CachingDirectoryFactory.close Closing directory when closing factory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 18242 T53 oasc.CachingDirectoryFactory.closeDirectory Closing directory:/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./solrtest-BasicZkTest-1357966935540
[junit4:junit4] 2> 18243 T67 oasc.Overseer$ClusterStateUpdater.amILeader According to ZK I (id=88995721107800067-188.138.97.18:null_solr-n_0000000000) am no longer a leader.
[junit4:junit4] 2> 18500 T66 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4] 2> 18500 T53 oaz.ZooKeeper.close Session: 0x13c2d2307290003 closed
[junit4:junit4] 2> NOTE: test params are: codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY, chunkSize=174)), sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=ro_RO, timezone=America/Denver
[junit4:junit4] 2> NOTE: Linux 3.2.0-35-generic i386/Sun Microsystems Inc. 1.6.0_38 (32-bit)/cpus=8,threads=1,free=45940792,total=64946176
[junit4:junit4] 2> NOTE: All tests run in this JVM: [TestCollationKeyRangeQueries, RAMDirectoryFactoryTest, QueryEqualityTest, XsltUpdateRequestHandlerTest, TestStressLucene, SynonymTokenizerTest, BasicZkTest]
[junit4:junit4] Completed on J1 in 18.55s, 1 test, 1 error <<< FAILURES!
[...truncated 709 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:344: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:178: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:428: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1176: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:841: There were test failures: 247 suites, 1032 tests, 1 error, 9 ignored (4 assumptions)
Total time: 29 minutes 8 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 32bit/jdk1.6.0_38 -server -XX:+UseSerialGC
Email was triggered for: Failure
Sending email for trigger: Failure