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 2014/02/08 01:00:00 UTC
[JENKINS] Lucene-Solr-4.x-Windows (64bit/jdk1.7.0_60-ea-b04) -
Build # 3681 - Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3681/
Java: 64bit/jdk1.7.0_60-ea-b04 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.cloud.OverseerRolesTest.testDistribSearch
Error Message:
Captured an uncaught exception in thread: Thread[id=1060, name=Overseer-91213958934429699-127.0.0.1:49248__ij%2Fz-n_0000000036, state=RUNNABLE, group=Overseer collection creation process.]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=1060, name=Overseer-91213958934429699-127.0.0.1:49248__ij%2Fz-n_0000000036, state=RUNNABLE, group=Overseer collection creation process.]
at __randomizedtesting.SeedInfo.seed([7A5132218D2E11D0:FBB7BC39FA7171EC]:0)
Caused by: org.apache.solr.common.cloud.ZooKeeperException:
at __randomizedtesting.SeedInfo.seed([7A5132218D2E11D0]:0)
at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:209)
at java.lang.Thread.run(Thread.java:744)
Caused by: org.apache.zookeeper.KeeperException$NoNodeException: KeeperErrorCode = NoNode for /overseer/collection-queue-work/qn-0000000004
at org.apache.zookeeper.KeeperException.create(KeeperException.java:111)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.delete(ZooKeeper.java:873)
at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:174)
at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:171)
at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
at org.apache.solr.common.cloud.SolrZkClient.delete(SolrZkClient.java:171)
at org.apache.solr.cloud.DistributedQueue.remove(DistributedQueue.java:193)
at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:200)
... 1 more
Build Log:
[...truncated 10049 lines...]
[junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
[junit4] 2> 245000 T866 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /_ij/z
[junit4] 2> 245009 T866 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-OverseerRolesTest-1391814558924
[junit4] 2> 245013 T866 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 2> 245015 T867 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 245120 T866 oasc.ZkTestServer.run start zk server on port:49241
[junit4] 2> 245123 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 245178 T873 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3b9c66e2 name:ZooKeeperConnection Watcher:127.0.0.1:49241 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 245181 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 245181 T866 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 245239 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 245244 T875 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6a8cf09b name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 245245 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 245245 T866 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4] 2> 245256 T866 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4] 2> 245262 T866 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4] 2> 245266 T866 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4] 2> 245273 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 245274 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 245287 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\schema.xml to /configs/conf1/schema.xml
[junit4] 2> 245288 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4] 2> 245296 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 245296 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 245304 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 245305 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4] 2> 245312 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 245313 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4] 2> 245321 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml
[junit4] 2> 245321 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4] 2> 245331 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 245334 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 245344 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 245345 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 245352 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 245353 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 245361 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 245362 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 245369 T866 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 245371 T866 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4] 2> 246060 T866 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 246071 T866 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49248
[junit4] 2> 246071 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 246071 T866 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 246071 T866 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295
[junit4] 2> 246071 T866 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295\'
[junit4] 2> 246111 T866 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295\solr.xml
[junit4] 2> 246207 T866 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 246207 T866 oasc.CoreContainer.<init> New CoreContainer 2048201353
[junit4] 2> 246207 T866 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295\]
[junit4] 2> 246220 T866 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 246220 T866 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 246220 T866 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 246220 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 246223 T866 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 246223 T866 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 246223 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 246223 T866 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 246223 T866 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 246236 T866 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 246236 T866 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 246236 T866 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 246236 T866 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49241/solr
[junit4] 2> 246239 T866 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 246242 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 246255 T886 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@529e72bc name:ZooKeeperConnection Watcher:127.0.0.1:49241 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 246256 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 246264 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 246272 T888 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7f1bf799 name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 246273 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 246279 T866 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 246290 T866 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4] 2> 246299 T866 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 246303 T866 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49248__ij%2Fz
[junit4] 2> 246306 T866 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49248__ij%2Fz
[junit4] 2> 246322 T866 oascc.SolrZkClient.makePath makePath: /overseer_elect
[junit4] 2> 246329 T866 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4] 2> 246341 T866 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:49248__ij%2Fz
[junit4] 2> 246341 T866 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 246350 T866 oasc.Overseer.start Overseer (id=91213958934429699-127.0.0.1:49248__ij%2Fz-n_0000000000) starting
[junit4] 2> 246361 T866 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4] 2> 246374 T890 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4] 2> 246375 T866 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 246378 T890 oasc.OverseerCollectionProcessor.prioritizeOverseerNodes prioritizing overseer nodes
[junit4] 2> 246384 T866 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 246389 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 246397 T889 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 246403 T866 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295
[junit4] 2> 246698 T866 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295\conf\
[junit4] 2> 246712 T866 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 246715 T866 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 246715 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 246717 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 246732 T893 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5624ea85 name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 246733 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 246736 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 246743 T866 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 247387 T866 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1
[junit4] 2> 247388 T866 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 247393 T866 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49260
[junit4] 2> 247394 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 247394 T866 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 247394 T866 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391814560657
[junit4] 2> 247394 T866 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391814560657\'
[junit4] 2> 247440 T866 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391814560657\solr.xml
[junit4] 2> 247549 T866 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 247549 T866 oasc.CoreContainer.<init> New CoreContainer 1009157816
[junit4] 2> 247549 T866 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391814560657\]
[junit4] 2> 247552 T866 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 247552 T866 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 247552 T866 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 247552 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 247552 T866 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 247552 T866 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 247552 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 247552 T866 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 247552 T866 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 247559 T866 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 247559 T866 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 247559 T866 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 247559 T866 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49241/solr
[junit4] 2> 247559 T866 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 247563 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 247574 T904 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@556b8e2 name:ZooKeeperConnection Watcher:127.0.0.1:49241 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247574 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 247581 T868 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x1440e9cc4d80005, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 247585 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 247591 T906 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@79be9b26 name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 247591 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 247605 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 248742 T866 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49260__ij%2Fz
[junit4] 2> 248750 T866 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49260__ij%2Fz
[junit4] 2> 248767 T888 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 248769 T906 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 248769 T893 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 248800 T866 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391814560657
[junit4] 2> 249137 T866 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391814560657\conf\
[junit4] 2> 249175 T866 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 249177 T866 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 249177 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 249907 T866 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2
[junit4] 2> 249909 T866 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 249914 T866 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49269
[junit4] 2> 249915 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 249917 T866 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 249917 T866 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391814563090
[junit4] 2> 249917 T866 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391814563090\'
[junit4] 2> 249960 T866 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391814563090\solr.xml
[junit4] 2> 250077 T866 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 250077 T866 oasc.CoreContainer.<init> New CoreContainer 2090350197
[junit4] 2> 250077 T866 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391814563090\]
[junit4] 2> 250080 T866 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 250080 T866 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 250080 T866 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 250080 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 250080 T866 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 250080 T866 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 250080 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 250080 T866 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 250080 T866 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 250088 T866 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 250088 T866 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 250088 T866 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 250088 T866 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49241/solr
[junit4] 2> 250088 T866 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 250093 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 250106 T918 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6d1f7b3a name:ZooKeeperConnection Watcher:127.0.0.1:49241 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 250107 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 250116 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 250124 T920 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@56b0eb1c name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 250125 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 250137 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 251298 T866 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49269__ij%2Fz
[junit4] 2> 251303 T866 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49269__ij%2Fz
[junit4] 2> 251314 T906 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 251315 T888 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 251316 T893 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 251316 T920 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 251331 T866 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391814563090
[junit4] 2> 251664 T866 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391814563090\conf\
[junit4] 2> 251681 T866 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 251682 T866 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 251682 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 252403 T866 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 3
[junit4] 2> 252405 T866 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 252412 T866 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49278
[junit4] 2> 252412 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 252412 T866 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 252412 T866 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391814565595
[junit4] 2> 252412 T866 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391814565595\'
[junit4] 2> 252470 T866 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391814565595\solr.xml
[junit4] 2> 252588 T866 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 252588 T866 oasc.CoreContainer.<init> New CoreContainer 82115571
[junit4] 2> 252588 T866 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391814565595\]
[junit4] 2> 252593 T866 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 252593 T866 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 252593 T866 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 252593 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 252593 T866 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 252593 T866 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 252593 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 252593 T866 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 252595 T866 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 252600 T866 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 252600 T866 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 252600 T866 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 252600 T866 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49241/solr
[junit4] 2> 252600 T866 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 252605 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 252611 T934 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@55591107 name:ZooKeeperConnection Watcher:127.0.0.1:49241 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 252613 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 252620 T868 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x1440e9cc4d80009, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 252623 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 252627 T936 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6e0ebbdf name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 252627 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 252641 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 253802 T866 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49278__ij%2Fz
[junit4] 2> 253805 T866 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49278__ij%2Fz
[junit4] 2> 253815 T893 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 253817 T936 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 253817 T920 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 253819 T888 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 253820 T906 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 253835 T866 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391814565595
[junit4] 2> 254184 T866 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391814565595\conf\
[junit4] 2> 254204 T866 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 254206 T866 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 254207 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 254900 T866 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 4
[junit4] 2> 254900 T866 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 254905 T866 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49287
[junit4] 2> 254906 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 254906 T866 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 254906 T866 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391814568121
[junit4] 2> 254906 T866 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391814568121\'
[junit4] 2> 254948 T866 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391814568121\solr.xml
[junit4] 2> 255066 T866 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 255066 T866 oasc.CoreContainer.<init> New CoreContainer 446940391
[junit4] 2> 255066 T866 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391814568121\]
[junit4] 2> 255069 T866 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 255069 T866 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 255069 T866 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 255069 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 255069 T866 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 255070 T866 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 255070 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 255070 T866 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 255070 T866 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 255077 T866 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 255077 T866 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 255077 T866 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 255077 T866 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49241/solr
[junit4] 2> 255078 T866 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 255082 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 255093 T948 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@75d4275a name:ZooKeeperConnection Watcher:127.0.0.1:49241 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 255094 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 255100 T868 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x1440e9cc4d8000b, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 255102 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 255109 T950 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3b377670 name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 255109 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 255127 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 256286 T866 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49287__ij%2Fz
[junit4] 2> 256290 T866 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49287__ij%2Fz
[junit4] 2> 256303 T920 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 256306 T950 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 256306 T906 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 256308 T936 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 256309 T888 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 256310 T893 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 256322 T866 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391814568121
[junit4] 2> 256679 T866 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391814568121\conf\
[junit4] 2> 256694 T866 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 256696 T866 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 256696 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 257377 T866 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 5
[junit4] 2> 257378 T866 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 257383 T866 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49296
[junit4] 2> 257385 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 257385 T866 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 257385 T866 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391814570610
[junit4] 2> 257385 T866 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391814570610\'
[junit4] 2> 257424 T866 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391814570610\solr.xml
[junit4] 2> 257535 T866 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 257535 T866 oasc.CoreContainer.<init> New CoreContainer 1796127844
[junit4] 2> 257535 T866 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391814570610\]
[junit4] 2> 257538 T866 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 257538 T866 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 257538 T866 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 257538 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 257538 T866 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 257538 T866 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 257540 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 257540 T866 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 257540 T866 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 257547 T866 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 257547 T866 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 257547 T866 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 257547 T866 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49241/solr
[junit4] 2> 257547 T866 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 257551 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 257567 T962 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@14728025 name:ZooKeeperConnection Watcher:127.0.0.1:49241 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 257568 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 257583 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 257593 T964 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@4e41c5a7 name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 257594 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 257620 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 258784 T866 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49296__ij%2Fz
[junit4] 2> 258791 T866 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49296__ij%2Fz
[junit4] 2> 258806 T888 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 258806 T906 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 258806 T893 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 258807 T950 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 258808 T964 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 258808 T920 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 258809 T936 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 258825 T866 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391814570610
[junit4] 2> 259148 T866 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391814570610\conf\
[junit4] 2> 259161 T866 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 259164 T866 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 259164 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 259794 T866 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 6
[junit4] 2> 259795 T866 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 259803 T866 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:49305
[junit4] 2> 259805 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 259805 T866 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 259807 T866 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077
[junit4] 2> 259808 T866 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077\'
[junit4] 2> 259860 T866 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077\solr.xml
[junit4] 2> 260008 T866 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 260008 T866 oasc.CoreContainer.<init> New CoreContainer 166082136
[junit4] 2> 260008 T866 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077\]
[junit4] 2> 260012 T866 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 260012 T866 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 260012 T866 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 260012 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 260013 T866 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 260013 T866 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 260013 T866 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 260013 T866 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 260013 T866 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 260015 T866 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 260015 T866 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 260015 T866 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 260016 T866 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:49241/solr
[junit4] 2> 260019 T866 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 260020 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 260037 T976 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@68f9d07b name:ZooKeeperConnection Watcher:127.0.0.1:49241 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 260038 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 260043 T868 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x1440e9cc4d8000f, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 260045 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 260051 T978 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@54b86e48 name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 260051 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 260070 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 261118 T866 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:49305__ij%2Fz
[junit4] 2> 261122 T866 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:49305__ij%2Fz
[junit4] 2> 261131 T893 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 261132 T920 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 261132 T936 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 261133 T888 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 261133 T978 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 261134 T906 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 261134 T964 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 261135 T950 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 261150 T866 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077
[junit4] 2> 261389 T866 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077\conf\
[junit4] 2> 261409 T866 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 261410 T866 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 261411 T866 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 261413 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 261426 T981 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@64c78d51 name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 261426 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 261431 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 261442 T866 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 261447 T983 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@593c82ea name:ZooKeeperConnection Watcher:127.0.0.1:49241/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 261448 T866 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 261451 T866 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 261467 T927 oasha.CollectionsHandler.handleCreateAction Creating Collection : version=2&name=testOverseerCol&wt=javabin&maxShardsPerNode=2&replicationFactor=2&action=CREATE&numShards=4
[junit4] 2> 261472 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261475 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261476 T890 oasc.OverseerCollectionProcessor.run Overseer Collection Processor: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "operation":"createcollection",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"testOverseerCol",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "numShards":"4",
[junit4] 2> "maxShardsPerNode":"2"}
[junit4] 2> 261476 T890 oasc.OverseerCollectionProcessor.processMessage WARN OverseerCollectionProcessor.processMessage : createcollection , {
[junit4] 2> "operation":"createcollection",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"testOverseerCol",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "numShards":"4",
[junit4] 2> "maxShardsPerNode":"2"}
[junit4] 2> 261479 T890 oasc.OverseerCollectionProcessor.createConfNode Only one config set found in zk - using it:conf1
[junit4] 2> 261479 T890 oasc.OverseerCollectionProcessor.createConfNode creating collections conf node /collections/testOverseerCol
[junit4] 2> 261479 T890 oascc.SolrZkClient.makePath makePath: /collections/testOverseerCol
[junit4] 2> 261494 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261497 T889 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 261498 T889 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: testOverseerCol
[junit4] 2> 261498 T889 oasc.Overseer$ClusterStateUpdater.createCollection Create collection testOverseerCol with shards [shard1, shard2, shard3, shard4]
[junit4] 2> 261505 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261508 T893 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261508 T978 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261508 T950 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261509 T906 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261509 T964 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261509 T983 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261510 T936 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261510 T888 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261511 T920 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261513 T981 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261598 T890 oasc.OverseerCollectionProcessor.createCollection going to create cores replicas shardNames [shard1, shard2, shard3, shard4] , repFactor : 2
[junit4] 2> 261598 T890 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard1_replica1 as part of slice shard1 of collection testOverseerCol on 127.0.0.1:49305__ij%2Fz
[junit4] 2> 261601 T890 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard1_replica2 as part of slice shard1 of collection testOverseerCol on 127.0.0.1:49260__ij%2Fz
[junit4] 2> 261602 T890 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard2_replica1 as part of slice shard2 of collection testOverseerCol on 127.0.0.1:49278__ij%2Fz
[junit4] 2> 261604 T890 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard2_replica2 as part of slice shard2 of collection testOverseerCol on 127.0.0.1:49287__ij%2Fz
[junit4] 2> 261608 T890 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard3_replica1 as part of slice shard3 of collection testOverseerCol on 127.0.0.1:49296__ij%2Fz
[junit4] 2> 261609 T890 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard3_replica2 as part of slice shard3 of collection testOverseerCol on 127.0.0.1:49248__ij%2Fz
[junit4] 2> 261626 T890 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard4_replica1 as part of slice shard4 of collection testOverseerCol on 127.0.0.1:49269__ij%2Fz
[junit4] 2> 261627 T973 oasc.ZkController.publish publishing core=testOverseerCol_shard1_replica1 state=down
[junit4] 2> 261630 T945 oasc.ZkController.publish publishing core=testOverseerCol_shard2_replica2 state=down
[junit4] 2> 261628 T890 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard4_replica2 as part of slice shard4 of collection testOverseerCol on 127.0.0.1:49305__ij%2Fz
[junit4] 2> 261627 T930 oasc.ZkController.publish publishing core=testOverseerCol_shard2_replica1 state=down
[junit4] 2> 261627 T958 oasc.ZkController.publish publishing core=testOverseerCol_shard3_replica1 state=down
[junit4] 2> 261635 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261637 T912 oasc.ZkController.publish publishing core=testOverseerCol_shard4_replica1 state=down
[junit4] 2> 261635 T945 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 261639 T958 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 261640 T930 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 261635 T973 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 261635 T883 oasc.ZkController.publish publishing core=testOverseerCol_shard3_replica2 state=down
[junit4] 2> 261634 T898 oasc.ZkController.publish publishing core=testOverseerCol_shard1_replica2 state=down
[junit4] 2> 261645 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261646 T912 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 261646 T974 oasc.ZkController.publish publishing core=testOverseerCol_shard4_replica2 state=down
[junit4] 2> 261649 T883 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 261649 T898 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 261650 T889 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 261651 T974 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 261652 T889 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49305/_ij/z",
[junit4] 2> "core":"testOverseerCol_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49305__ij%2Fz",
[junit4] 2> "shard":"shard1",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 261662 T889 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49287/_ij/z",
[junit4] 2> "core":"testOverseerCol_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49287__ij%2Fz",
[junit4] 2> "shard":"shard2",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 261669 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261671 T889 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49296/_ij/z",
[junit4] 2> "core":"testOverseerCol_shard3_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49296__ij%2Fz",
[junit4] 2> "shard":"shard3",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 261678 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261680 T889 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49278/_ij/z",
[junit4] 2> "core":"testOverseerCol_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49278__ij%2Fz",
[junit4] 2> "shard":"shard2",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 261687 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261689 T889 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49269/_ij/z",
[junit4] 2> "core":"testOverseerCol_shard4_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49269__ij%2Fz",
[junit4] 2> "shard":"shard4",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 261695 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261698 T889 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49248/_ij/z",
[junit4] 2> "core":"testOverseerCol_shard3_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49248__ij%2Fz",
[junit4] 2> "shard":"shard3",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 261709 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261711 T889 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49260/_ij/z",
[junit4] 2> "core":"testOverseerCol_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49260__ij%2Fz",
[junit4] 2> "shard":"shard1",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 261717 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261720 T889 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:49305/_ij/z",
[junit4] 2> "core":"testOverseerCol_shard4_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:49305__ij%2Fz",
[junit4] 2> "shard":"shard4",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 261727 T888 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 261841 T981 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261841 T950 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261843 T964 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261844 T906 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261846 T978 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261846 T888 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261842 T983 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261842 T893 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261847 T920 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 261847 T936 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 262674 T945 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard2_replica2
[junit4] 2> 262675 T930 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard2_replica1
[junit4] 2> 262674 T958 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard3_replica1
[junit4] 2> 262677 T973 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard1_replica1
[junit4] 2> 262681 T945 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard2_replica2' using instanceDir: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391814568121\testOverseerCol_shard2_replica2
[junit4] 2> 262681 T945 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 262681 T958 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard3_replica1' using instanceDir: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391814570610\testOverseerCol_shard3_replica1
[junit4] 2> 262684 T958 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 262699 T883 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard3_replica2
[junit4] 2> 262699 T930 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard2_replica1' using instanceDir: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391814565595\testOverseerCol_shard2_replica1
[junit4] 2> 262699 T930 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 262698 T912 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard4_replica1
[junit4] 2> 262700 T883 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard3_replica2' using instanceDir: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295\testOverseerCol_shard3_replica2
[junit4] 2> 262700 T883 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 262703 T912 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard4_replica1' using instanceDir: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391814563090\testOverseerCol_shard4_replica1
[junit4] 2> 262703 T912 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 262698 T974 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard4_replica2
[junit4] 2> 262704 T973 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard1_replica1' using instanceDir: .\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077\testOverseerCol_shard1_replica1
[junit4] 2> 262704 T973 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 262705 T974 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard4_replica2' using instanceDir: .\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077\testOverseerCol_shard4_replica2
[junit4] 2> 262705 T974 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 262698 T898 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard1_replica2
[junit4] 2> 262707 T958 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 262707 T958 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 262709 T898 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard1_replica2' using instanceDir: .\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391814560657\testOverseerCol_shard1_replica2
[junit4] 2> 262710 T898 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 262710 T912 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 262711 T912 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 262710 T930 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 262711 T974 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 262712 T974 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 262713 T898 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 262711 T945 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 262713 T945 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 262711 T973 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 262714 T973 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 262711 T883 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 262716 T883 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 262716 T974 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 262717 T974 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077\testOverseerCol_shard4_replica2\'
[junit4] 2> 262716 T912 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 262717 T912 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391814563090\testOverseerCol_shard4_replica1\'
[junit4] 2> 262721 T945 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 262721 T945 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391814568121\testOverseerCol_shard2_replica2\'
[junit4] 2> 262714 T958 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 262724 T973 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 262724 T973 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391814573077\testOverseerCol_shard1_replica1\'
[junit4] 2> 262713 T898 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 262712 T930 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 262756 T883 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 262769 T883 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295\testOverseerCol_shard3_replica2\'
[junit4] 2> 262727 T958 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391814570610\testOverseerCol_shard3_replica1\'
[junit4] 2> 262774 T898 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 262774 T898 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391814560657\testOverseerCol_shard1_replica2\'
[junit4] 2> 262809 T930 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 262809 T930 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391814565595\testOverseerCol_shard2_replica1\'
[junit4] 2> 262946 T973 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 263053 T945 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 263133 T883 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 263268 T974 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 263273 T912 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 263343 T973 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 263377 T958 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 263383 T973 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 263399 T945 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 263450 T898 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 263541 T945 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 263542 T973 oass.IndexSchema.readSchema [testOverseerCol_shard1_replica1] Schema name=test
[junit4] 2> 263583 T945 oass.IndexSchema.readSchema [testOverseerCol_shard2_replica2] Schema name=test
[junit4] 2> 263627 T930 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 263784 T974 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 263806 T912 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 263832 T898 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 263852 T974 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 263853 T912 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 263853 T898 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 263877 T898 oass.IndexSchema.readSchema [testOverseerCol_shard1_replica2] Schema name=test
[junit4] 2> 263904 T912 oass.IndexSchema.readSchema [testOverseerCol_shard4_replica1] Schema name=test
[junit4] 2> 263931 T883 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 264003 T974 oass.IndexSchema.readSchema [testOverseerCol_shard4_replica2] Schema name=test
[junit4] 2> 264096 T883 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 264122 T883 oass.IndexSchema.readSchema [testOverseerCol_shard3_replica2] Schema name=test
[junit4] 2> 264292 T958 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 264296 T930 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 264331 T958 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 264336 T930 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 264358 T958 oass.IndexSchema.readSchema [testOverseerCol_shard3_replica1] Schema name=test
[junit4] 2> 264379 T930 oass.IndexSchema.readSchema [testOverseerCol_shard2_replica1] Schema name=test
[junit4] 2> 267185 T883 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 267186 T883 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 267188 T883 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 267209 T883 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 267213 T883 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 267635 T973 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 267636 T973 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 267638 T973 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 267740 T973 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 267743 T973 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 267889 T945 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 267890 T945 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 267891 T945 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 267984 T945 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 268086 T883 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 268109 T945 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 268147 T883 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 268279 T883 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 268296 T898 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 268296 T898 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 268298 T898 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 268388 T883 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 268388 T883 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 268388 T883 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 268407 T974 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 268407 T974 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 268410 T974 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 268418 T974 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 268462 T898 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 268468 T898 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 268492 T883 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 268492 T883 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 268492 T883 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 268493 T883 oasc.SolrCore.<init> [testOverseerCol_shard3_replica2] Opening new SolrCore at ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295\testOverseerCol_shard3_replica2\, dataDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295\testOverseerCol_shard3_replica2\data\
[junit4] 2> 268496 T974 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 268515 T930 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 268573 T930 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 268574 T930 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 268577 T883 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@559be5ba
[junit4] 2> 268584 T883 oasc.CachingDirectoryFactory.get return new directory for ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391814559295\testOverseerCol_shard3_replica2\data\
[junit4] 2> 26
[...truncated too long message...]
pache.solr.cloud.ShardLeaderElectionContextBase.runLeaderProcess(ElectionContext.java:112)
[junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:273)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:164)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:108)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 277837 T964 oasc.LeaderElector$1.process WARN org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections/testOverseerCol/leader_elect/shard3/election/91213958934429710-core_node3-n_0000000001
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.delete(ZooKeeper.java:873)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:174)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:171)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.delete(SolrZkClient.java:171)
[junit4] 2> at org.apache.solr.cloud.ElectionContext.cancelElection(ElectionContext.java:67)
[junit4] 2> at org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:293)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:164)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:108)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 277837 T964 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 277837 T964 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 277837 T964 oascc.ZkStateReader$2.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 277840 T964 oasc.LeaderElector$1.process WARN org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1468)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:257)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:92)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 276723 T936 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 276631 T920 oasc.LeaderElector$1.process WARN org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1468)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:257)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:92)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 277843 T920 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 277842 T964 oasc.LeaderElector$1.process WARN org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1468)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:257)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:92)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 32845 T865 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene46: {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=zh_SG, timezone=America/Rosario
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_60-ea (64-bit)/cpus=2,threads=1,free=255079656,total=323379200
[junit4] 2> NOTE: All tests run in this JVM: [HdfsDirectoryTest, TestIndexingPerformance, HdfsSyncSliceTest, TestGroupingSearch, TestCopyFieldCollectionResource, QueryElevationComponentTest, TestDynamicFieldResource, TestFieldCollectionResource, SortByFunctionTest, TestNumberUtils, SynonymTokenizerTest, TestCursorMarkWithoutUniqueKey, TestSolrJ, TestJoin, CoreAdminHandlerTest, OpenExchangeRatesOrgProviderTest, TestManagedSchema, TestStressUserVersions, TestRemoteStreaming, TestSolrQueryParserResource, TestZkChroot, StatelessScriptUpdateProcessorFactoryTest, TestRecovery, NoCacheHeaderTest, ShardRoutingTest, TestUniqueKeyFieldResource, HdfsCollectionsAPIDistributedZkTest, CursorMarkTest, DistributedSpellCheckComponentTest, TestFieldTypeCollectionResource, OverseerRolesTest]
[junit4] Completed in 33.17s, 1 test, 1 error <<< FAILURES!
[...truncated 1025 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:459: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:439: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:491: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1308: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:941: There were test failures: 358 suites, 1554 tests, 1 error, 40 ignored (12 assumptions)
Total time: 81 minutes 22 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0_60-ea-b04 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
[JENKINS] Lucene-Solr-4.x-Windows (32bit/jdk1.8.0-fcs-b128) - Build
# 3682 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/3682/
Java: 32bit/jdk1.8.0-fcs-b128 -server -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.cloud.OverseerRolesTest.testDistribSearch
Error Message:
Captured an uncaught exception in thread: Thread[id=3533, name=Overseer-91215865666928654-127.0.0.1:63773_-n_0000000036, state=RUNNABLE, group=Overseer collection creation process.]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=3533, name=Overseer-91215865666928654-127.0.0.1:63773_-n_0000000036, state=RUNNABLE, group=Overseer collection creation process.]
at __randomizedtesting.SeedInfo.seed([6276BE3555ED57FC:E390302D22B237C0]:0)
Caused by: org.apache.solr.common.cloud.ZooKeeperException:
at __randomizedtesting.SeedInfo.seed([6276BE3555ED57FC]:0)
at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:209)
at java.lang.Thread.run(Thread.java:744)
Caused by: org.apache.zookeeper.KeeperException$NoNodeException: KeeperErrorCode = NoNode for /overseer/collection-queue-work/qn-0000000004
at org.apache.zookeeper.KeeperException.create(KeeperException.java:111)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.delete(ZooKeeper.java:873)
at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:174)
at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:171)
at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
at org.apache.solr.common.cloud.SolrZkClient.delete(SolrZkClient.java:171)
at org.apache.solr.cloud.DistributedQueue.remove(DistributedQueue.java:193)
at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:200)
... 1 more
Build Log:
[...truncated 10215 lines...]
[junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
[junit4] 2> 603255 T3339 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: /
[junit4] 2> 603258 T3339 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\solrtest-OverseerRolesTest-1391843653354
[junit4] 2> 603262 T3339 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4] 2> 603263 T3340 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server
[junit4] 2> 603358 T3339 oasc.ZkTestServer.run start zk server on port:63718
[junit4] 2> 603359 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 603374 T3346 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@bc8a70 name:ZooKeeperConnection Watcher:127.0.0.1:63718 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 603375 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 603375 T3339 oascc.SolrZkClient.makePath makePath: /solr
[junit4] 2> 603381 T3341 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x1441058b6f50000, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 603384 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 603388 T3348 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@686117 name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 603389 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 603389 T3339 oascc.SolrZkClient.makePath makePath: /collections/collection1
[junit4] 2> 603393 T3339 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4] 2> 603398 T3339 oascc.SolrZkClient.makePath makePath: /collections/control_collection
[junit4] 2> 603402 T3339 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards
[junit4] 2> 603408 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 603409 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 603417 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\schema.xml to /configs/conf1/schema.xml
[junit4] 2> 603418 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml
[junit4] 2> 603423 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 603424 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 603429 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 603430 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt
[junit4] 2> 603435 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 603436 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt
[junit4] 2> 603440 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml
[junit4] 2> 603440 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml
[junit4] 2> 603448 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 603448 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 603452 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 603453 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 603458 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 603459 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 603462 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 603463 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 603468 T3339 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 603469 T3339 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt
[junit4] 2> 604108 T3339 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 604114 T3339 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63725
[junit4] 2> 604115 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 604116 T3339 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 604116 T3339 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391843653570
[junit4] 2> 604117 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391843653570\'
[junit4] 2> 604165 T3339 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391843653570\solr.xml
[junit4] 2> 604177 T3339 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 604178 T3339 oasc.CoreContainer.<init> New CoreContainer 11063168
[junit4] 2> 604178 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391843653570\]
[junit4] 2> 604178 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 604178 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 604179 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 604179 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 604179 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 604180 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 604180 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 604180 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 604180 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 604185 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 604185 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 604186 T3339 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 604186 T3339 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:63718/solr
[junit4] 2> 604186 T3339 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 604188 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 604197 T3359 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@527b17 name:ZooKeeperConnection Watcher:127.0.0.1:63718 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 604197 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 604204 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 604209 T3361 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@11f0d25 name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 604209 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 604213 T3339 oascc.SolrZkClient.makePath makePath: /overseer/queue
[junit4] 2> 604226 T3339 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work
[junit4] 2> 604231 T3339 oascc.SolrZkClient.makePath makePath: /live_nodes
[junit4] 2> 604236 T3339 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63725_
[junit4] 2> 604239 T3339 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:63725_
[junit4] 2> 604245 T3339 oascc.SolrZkClient.makePath makePath: /overseer_elect
[junit4] 2> 604250 T3339 oascc.SolrZkClient.makePath makePath: /overseer_elect/election
[junit4] 2> 604260 T3339 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:63725_
[junit4] 2> 604261 T3339 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader
[junit4] 2> 604265 T3339 oasc.Overseer.start Overseer (id=91215865666928643-127.0.0.1:63725_-n_0000000000) starting
[junit4] 2> 604271 T3339 oascc.SolrZkClient.makePath makePath: /overseer/queue-work
[junit4] 2> 604278 T3363 oasc.OverseerCollectionProcessor.run Process current queue of collection creations
[junit4] 2> 604281 T3339 oascc.SolrZkClient.makePath makePath: /clusterstate.json
[junit4] 2> 604281 T3363 oasc.OverseerCollectionProcessor.prioritizeOverseerNodes prioritizing overseer nodes
[junit4] 2> 604287 T3339 oascc.SolrZkClient.makePath makePath: /aliases.json
[junit4] 2> 604291 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 604296 T3362 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue
[junit4] 2> 604296 T3339 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391843653570
[junit4] 2> 604647 T3339 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391843653570\conf\
[junit4] 2> 604665 T3339 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 604667 T3339 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 604667 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 604669 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 604673 T3366 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1d5ccfc name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 604673 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 604675 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 604680 T3339 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 605283 T3339 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1
[junit4] 2> 605285 T3339 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 605288 T3339 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63737
[junit4] 2> 605289 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 605289 T3339 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 605290 T3339 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391843654773
[junit4] 2> 605290 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391843654773\'
[junit4] 2> 605318 T3339 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391843654773\solr.xml
[junit4] 2> 605334 T3339 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 605334 T3339 oasc.CoreContainer.<init> New CoreContainer 7255849
[junit4] 2> 605335 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391843654773\]
[junit4] 2> 605337 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 605337 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 605338 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 605338 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 605338 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 605338 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 605338 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 605338 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 605338 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 605345 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 605345 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 605345 T3339 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 605345 T3339 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:63718/solr
[junit4] 2> 605349 T3339 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 605350 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 605358 T3379 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8c9026 name:ZooKeeperConnection Watcher:127.0.0.1:63718 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 605359 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 605364 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 605368 T3381 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@15b4ec name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 605369 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 605376 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 606334 T3339 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63737_
[junit4] 2> 606336 T3339 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:63737_
[junit4] 2> 606341 T3366 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 606341 T3381 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 606342 T3361 oascc.ZkStateReader$3.process Updating live nodes... (2)
[junit4] 2> 606350 T3339 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391843654773
[junit4] 2> 606737 T3339 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391843654773\conf\
[junit4] 2> 606753 T3339 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 606755 T3339 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 606755 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 607383 T3339 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2
[junit4] 2> 607384 T3339 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 607393 T3339 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63746
[junit4] 2> 607393 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 607393 T3339 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 607393 T3339 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391843656848
[junit4] 2> 607393 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391843656848\'
[junit4] 2> 607423 T3339 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391843656848\solr.xml
[junit4] 2> 607438 T3339 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 607438 T3339 oasc.CoreContainer.<init> New CoreContainer 12207693
[junit4] 2> 607438 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391843656848\]
[junit4] 2> 607440 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 607440 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 607440 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 607440 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 607440 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 607440 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 607443 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 607443 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 607443 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 607445 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 607447 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 607447 T3339 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 607447 T3339 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:63718/solr
[junit4] 2> 607447 T3339 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 607450 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 607461 T3393 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@e521fc name:ZooKeeperConnection Watcher:127.0.0.1:63718 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 607461 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 607465 T3341 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x1441058b6f50007, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 607467 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 607473 T3395 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@661212 name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 607473 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 607479 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 608436 T3339 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63746_
[junit4] 2> 608447 T3339 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:63746_
[junit4] 2> 608458 T3395 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 608459 T3381 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 608460 T3361 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 608460 T3366 oascc.ZkStateReader$3.process Updating live nodes... (3)
[junit4] 2> 608469 T3339 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391843656848
[junit4] 2> 608927 T3339 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391843656848\conf\
[junit4] 2> 608945 T3339 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 608946 T3339 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 608946 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 609533 T3339 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 3
[junit4] 2> 609533 T3339 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 609542 T3339 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63755
[junit4] 2> 609543 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 609543 T3339 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 609543 T3339 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391843659040
[junit4] 2> 609543 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391843659040\'
[junit4] 2> 609577 T3339 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391843659040\solr.xml
[junit4] 2> 609604 T3339 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 609605 T3339 oasc.CoreContainer.<init> New CoreContainer 31153894
[junit4] 2> 609606 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391843659040\]
[junit4] 2> 609606 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 609607 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 609607 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 609608 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 609608 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 609608 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 609608 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 609609 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 609609 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 609613 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 609614 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 609615 T3339 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 609616 T3339 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:63718/solr
[junit4] 2> 609616 T3339 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 609619 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 609634 T3407 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1fa3dfe name:ZooKeeperConnection Watcher:127.0.0.1:63718 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 609635 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 609641 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 609648 T3409 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1fad086 name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 609648 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 609661 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 610617 T3339 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63755_
[junit4] 2> 610620 T3339 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:63755_
[junit4] 2> 610627 T3395 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 610627 T3409 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 610627 T3361 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 610628 T3381 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 610628 T3366 oascc.ZkStateReader$3.process Updating live nodes... (4)
[junit4] 2> 610635 T3339 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391843659040
[junit4] 2> 610952 T3339 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391843659040\conf\
[junit4] 2> 610973 T3339 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 610975 T3339 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 610976 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 611609 T3339 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 4
[junit4] 2> 611610 T3339 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 611617 T3339 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63764
[junit4] 2> 611618 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 611618 T3339 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 611618 T3339 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: .\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391843661069
[junit4] 2> 611618 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391843661069\'
[junit4] 2> 611652 T3339 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391843661069\solr.xml
[junit4] 2> 611666 T3339 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 611668 T3339 oasc.CoreContainer.<init> New CoreContainer 4694496
[junit4] 2> 611668 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391843661069\]
[junit4] 2> 611669 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 611669 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 611669 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 611669 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 611672 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 611672 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 611672 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 611672 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 611672 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 611677 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 611677 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 611677 T3339 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 611679 T3339 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:63718/solr
[junit4] 2> 611679 T3339 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 611681 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 611697 T3421 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1cff4df name:ZooKeeperConnection Watcher:127.0.0.1:63718 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 611698 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 611705 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 611710 T3423 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@151c374 name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 611711 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 611718 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 612761 T3339 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63764_
[junit4] 2> 612765 T3339 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:63764_
[junit4] 2> 612775 T3395 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 612776 T3366 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 612776 T3409 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 612777 T3361 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 612777 T3381 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 612778 T3423 oascc.ZkStateReader$3.process Updating live nodes... (5)
[junit4] 2> 612790 T3339 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391843661069
[junit4] 2> 613192 T3339 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391843661069\conf\
[junit4] 2> 613215 T3339 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 613216 T3339 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 613216 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 613884 T3339 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 5
[junit4] 2> 613885 T3339 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 613895 T3339 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63773
[junit4] 2> 613895 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 613895 T3339 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 613896 T3339 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310
[junit4] 2> 613897 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310\'
[junit4] 2> 613932 T3339 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310\solr.xml
[junit4] 2> 613948 T3339 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 613948 T3339 oasc.CoreContainer.<init> New CoreContainer 22105112
[junit4] 2> 613949 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310\]
[junit4] 2> 613949 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 613950 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 613950 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 613950 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 613951 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 613951 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 613951 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 613953 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 613953 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 613958 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 613958 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 613958 T3339 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 613959 T3339 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:63718/solr
[junit4] 2> 613959 T3339 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 613962 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 613971 T3435 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1b42b96 name:ZooKeeperConnection Watcher:127.0.0.1:63718 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 613972 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 613977 T3341 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x1441058b6f5000d, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 613979 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 613984 T3437 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1abbfba name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 613986 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 613999 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 615053 T3339 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63773_
[junit4] 2> 615056 T3339 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:63773_
[junit4] 2> 615064 T3423 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 615064 T3366 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 615065 T3361 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 615065 T3381 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 615065 T3409 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 615066 T3395 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 615066 T3437 oascc.ZkStateReader$3.process Updating live nodes... (6)
[junit4] 2> 615075 T3339 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310
[junit4] 2> 615408 T3339 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310\conf\
[junit4] 2> 615423 T3339 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 615424 T3339 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 615424 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 616009 T3339 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 6
[junit4] 2> 616011 T3339 oejs.Server.doStart jetty-8.1.10.v20130312
[junit4] 2> 616016 T3339 oejs.AbstractConnector.doStart Started SelectChannelConnector@127.0.0.1:63782
[junit4] 2> 616016 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4] 2> 616016 T3339 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 616016 T3339 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518
[junit4] 2> 616016 T3339 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518\'
[junit4] 2> 616050 T3339 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518\solr.xml
[junit4] 2> 616062 T3339 oasc.ConfigSolrXml.<init> Config-defined core root directory:
[junit4] 2> 616062 T3339 oasc.CoreContainer.<init> New CoreContainer 15720402
[junit4] 2> 616062 T3339 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518\]
[junit4] 2> 616063 T3339 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000
[junit4] 2> 616063 T3339 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4] 2> 616063 T3339 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000
[junit4] 2> 616063 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 616063 T3339 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 616063 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 616063 T3339 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 616067 T3339 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 616067 T3339 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 616069 T3339 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 616069 T3339 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 616069 T3339 oasc.CoreContainer.load Host Name: 127.0.0.1
[junit4] 2> 616069 T3339 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:63718/solr
[junit4] 2> 616071 T3339 oasc.ZkController.checkChrootPath zkHost includes chroot
[junit4] 2> 616074 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 616086 T3449 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@117681 name:ZooKeeperConnection Watcher:127.0.0.1:63718 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 616087 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 616095 T3341 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x1441058b6f5000f, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:220)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:744)
[junit4] 2>
[junit4] 2> 616098 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 616103 T3451 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@caa17b name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 616103 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 616116 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 617172 T3339 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63782_
[junit4] 2> 617174 T3339 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:63782_
[junit4] 2> 617182 T3366 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 617183 T3381 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 617183 T3451 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 617183 T3361 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 617184 T3409 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 617185 T3395 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 617185 T3437 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 617185 T3423 oascc.ZkStateReader$3.process Updating live nodes... (7)
[junit4] 2> 617193 T3339 oasc.CorePropertiesLocator.discover Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518
[junit4] 2> 617488 T3339 oasc.CorePropertiesLocator.discoverUnder Found core conf in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518\conf\
[junit4] 2> 617504 T3339 oasc.CorePropertiesLocator.discover Found 1 core definitions
[junit4] 2> 617505 T3339 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0
[junit4] 2> 617506 T3339 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4] 2> 617508 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 617512 T3454 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@523706 name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 617513 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 617515 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 617526 T3339 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper
[junit4] 2> 617529 T3456 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@8f7091 name:ZooKeeperConnection Watcher:127.0.0.1:63718/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 617529 T3339 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper
[junit4] 2> 617531 T3339 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper...
[junit4] 2> 617538 T3387 oasha.CollectionsHandler.handleCreateAction Creating Collection : replicationFactor=2&maxShardsPerNode=2&name=testOverseerCol&action=CREATE&numShards=4&wt=javabin&version=2
[junit4] 2> 617542 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617545 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/collection-queue-work state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617548 T3363 oasc.OverseerCollectionProcessor.run Overseer Collection Processor: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{
[junit4] 2> "operation":"createcollection",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"testOverseerCol",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "numShards":"4",
[junit4] 2> "maxShardsPerNode":"2"}
[junit4] 2> 617548 T3363 oasc.OverseerCollectionProcessor.processMessage WARN OverseerCollectionProcessor.processMessage : createcollection , {
[junit4] 2> "operation":"createcollection",
[junit4] 2> "fromApi":"true",
[junit4] 2> "name":"testOverseerCol",
[junit4] 2> "replicationFactor":"2",
[junit4] 2> "numShards":"4",
[junit4] 2> "maxShardsPerNode":"2"}
[junit4] 2> 617550 T3363 oasc.OverseerCollectionProcessor.createConfNode Only one config set found in zk - using it:conf1
[junit4] 2> 617550 T3363 oasc.OverseerCollectionProcessor.createConfNode creating collections conf node /collections/testOverseerCol
[junit4] 2> 617550 T3363 oascc.SolrZkClient.makePath makePath: /collections/testOverseerCol
[junit4] 2> 617559 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617561 T3362 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 617563 T3362 oasc.Overseer$ClusterStateUpdater.buildCollection building a new collection: testOverseerCol
[junit4] 2> 617563 T3362 oasc.Overseer$ClusterStateUpdater.createCollection Create collection testOverseerCol with shards [shard1, shard2, shard3, shard4]
[junit4] 2> 617569 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617572 T3456 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617573 T3454 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617575 T3366 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617576 T3381 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617577 T3361 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617578 T3451 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617578 T3423 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617580 T3437 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617581 T3395 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617582 T3409 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617664 T3363 oasc.OverseerCollectionProcessor.createCollection going to create cores replicas shardNames [shard1, shard2, shard3, shard4] , repFactor : 2
[junit4] 2> 617664 T3363 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard1_replica1 as part of slice shard1 of collection testOverseerCol on 127.0.0.1:63782_
[junit4] 2> 617665 T3363 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard1_replica2 as part of slice shard1 of collection testOverseerCol on 127.0.0.1:63764_
[junit4] 2> 617666 T3363 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard2_replica1 as part of slice shard2 of collection testOverseerCol on 127.0.0.1:63773_
[junit4] 2> 617668 T3363 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard2_replica2 as part of slice shard2 of collection testOverseerCol on 127.0.0.1:63755_
[junit4] 2> 617673 T3363 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard3_replica1 as part of slice shard3 of collection testOverseerCol on 127.0.0.1:63737_
[junit4] 2> 617677 T3444 oasc.ZkController.publish publishing core=testOverseerCol_shard1_replica1 state=down
[junit4] 2> 617676 T3431 oasc.ZkController.publish publishing core=testOverseerCol_shard2_replica1 state=down
[junit4] 2> 617679 T3416 oasc.ZkController.publish publishing core=testOverseerCol_shard1_replica2 state=down
[junit4] 2> 617680 T3363 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard3_replica2 as part of slice shard3 of collection testOverseerCol on 127.0.0.1:63725_
[junit4] 2> 617682 T3444 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 617682 T3431 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 617684 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617684 T3363 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard4_replica1 as part of slice shard4 of collection testOverseerCol on 127.0.0.1:63746_
[junit4] 2> 617685 T3363 oasc.OverseerCollectionProcessor.createCollection Creating shard testOverseerCol_shard4_replica2 as part of slice shard4 of collection testOverseerCol on 127.0.0.1:63782_
[junit4] 2> 617686 T3404 oasc.ZkController.publish publishing core=testOverseerCol_shard2_replica2 state=down
[junit4] 2> 617691 T3416 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 617692 T3376 oasc.ZkController.publish publishing core=testOverseerCol_shard3_replica1 state=down
[junit4] 2> 617693 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617694 T3404 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 617694 T3388 oasc.ZkController.publish publishing core=testOverseerCol_shard4_replica1 state=down
[junit4] 2> 617696 T3376 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 617700 T3352 oasc.ZkController.publish publishing core=testOverseerCol_shard3_replica2 state=down
[junit4] 2> 617700 T3362 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper...
[junit4] 2> 617700 T3388 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 617700 T3446 oasc.ZkController.publish publishing core=testOverseerCol_shard4_replica2 state=down
[junit4] 2> 617703 T3352 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 617704 T3362 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:63782",
[junit4] 2> "core":"testOverseerCol_shard1_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:63782_",
[junit4] 2> "shard":"shard1",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 617705 T3446 oasc.ZkController.waitForCoreNodeName look for our core node name
[junit4] 2> 617715 T3362 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:63773",
[junit4] 2> "core":"testOverseerCol_shard2_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:63773_",
[junit4] 2> "shard":"shard2",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 617720 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617722 T3362 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:63764",
[junit4] 2> "core":"testOverseerCol_shard1_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:63764_",
[junit4] 2> "shard":"shard1",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 617727 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617729 T3362 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:63755",
[junit4] 2> "core":"testOverseerCol_shard2_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:63755_",
[junit4] 2> "shard":"shard2",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 617734 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617735 T3362 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:63737",
[junit4] 2> "core":"testOverseerCol_shard3_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:63737_",
[junit4] 2> "shard":"shard3",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 617741 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617742 T3362 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:63746",
[junit4] 2> "core":"testOverseerCol_shard4_replica1",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:63746_",
[junit4] 2> "shard":"shard4",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 617748 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617749 T3362 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:63725",
[junit4] 2> "core":"testOverseerCol_shard3_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:63725_",
[junit4] 2> "shard":"shard3",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 617754 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617756 T3362 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={
[junit4] 2> "operation":"state",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:63782",
[junit4] 2> "core":"testOverseerCol_shard4_replica2",
[junit4] 2> "roles":null,
[junit4] 2> "node_name":"127.0.0.1:63782_",
[junit4] 2> "shard":"shard4",
[junit4] 2> "shard_range":null,
[junit4] 2> "shard_state":"active",
[junit4] 2> "shard_parent":null,
[junit4] 2> "collection":"testOverseerCol",
[junit4] 2> "numShards":"4",
[junit4] 2> "core_node_name":null}
[junit4] 2> 617761 T3361 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged
[junit4] 2> 617870 T3381 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617871 T3361 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617871 T3451 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617871 T3423 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617872 T3437 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617872 T3456 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617873 T3395 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617874 T3409 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617874 T3454 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 617875 T3366 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 7)
[junit4] 2> 618728 T3431 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard2_replica1
[junit4] 2> 618728 T3444 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard1_replica1
[junit4] 2> 618732 T3431 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard2_replica1' using instanceDir: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310\testOverseerCol_shard2_replica1
[junit4] 2> 618732 T3431 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 618732 T3444 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard1_replica1' using instanceDir: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518\testOverseerCol_shard1_replica1
[junit4] 2> 618733 T3444 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 618733 T3431 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 618734 T3431 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 618734 T3444 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 618734 T3444 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 618736 T3444 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 618736 T3444 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518\testOverseerCol_shard1_replica1\'
[junit4] 2> 618736 T3431 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 618737 T3431 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310\testOverseerCol_shard2_replica1\'
[junit4] 2> 618741 T3416 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard1_replica2
[junit4] 2> 618741 T3404 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard2_replica2
[junit4] 2> 618742 T3376 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard3_replica1
[junit4] 2> 618745 T3376 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard3_replica1' using instanceDir: .\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391843654773\testOverseerCol_shard3_replica1
[junit4] 2> 618745 T3376 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 618747 T3376 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 618747 T3376 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 618749 T3404 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard2_replica2' using instanceDir: .\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391843659040\testOverseerCol_shard2_replica2
[junit4] 2> 618749 T3404 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 618756 T3388 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard4_replica1
[junit4] 2> 618758 T3416 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard1_replica2' using instanceDir: .\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391843661069\testOverseerCol_shard1_replica2
[junit4] 2> 618758 T3416 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 618759 T3404 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 618759 T3404 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 618761 T3352 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard3_replica2
[junit4] 2> 618761 T3416 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 618763 T3416 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 618763 T3376 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 618763 T3376 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty1-1391843654773\testOverseerCol_shard3_replica1\'
[junit4] 2> 618775 T3404 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 618775 T3404 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty3-1391843659040\testOverseerCol_shard2_replica2\'
[junit4] 2> 618782 T3388 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard4_replica1' using instanceDir: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391843656848\testOverseerCol_shard4_replica1
[junit4] 2> 618782 T3388 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 618792 T3416 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 618792 T3416 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-jetty4-1391843661069\testOverseerCol_shard1_replica2\'
[junit4] 2> 618812 T3388 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 618812 T3388 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 618817 T3352 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard3_replica2' using instanceDir: .\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391843653570\testOverseerCol_shard3_replica2
[junit4] 2> 618817 T3352 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 618825 T3431 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 618834 T3431 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 618825 T3376 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 618834 T3404 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 618855 T3446 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for testOverseerCol_shard4_replica2
[junit4] 2> 618860 T3446 oasc.CoreContainer.create Creating SolrCore 'testOverseerCol_shard4_replica2' using instanceDir: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518\testOverseerCol_shard4_replica2
[junit4] 2> 618860 T3446 oasc.ZkController.createCollectionZkNode Check for collection zkNode:testOverseerCol
[junit4] 2> 618866 T3376 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 618868 T3388 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 618868 T3388 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty2-1391843656848\testOverseerCol_shard4_replica1\'
[junit4] 2> 618872 T3404 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 618885 T3416 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 618896 T3416 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 618901 T3352 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 618901 T3352 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 618904 T3431 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 618906 T3376 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 618910 T3404 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 618913 T3416 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 618913 T3446 oasc.ZkController.createCollectionZkNode Collection zkNode exists
[junit4] 2> 618913 T3446 oascc.ZkStateReader.readConfigName Load collection config from:/collections/testOverseerCol
[junit4] 2> 618920 T3376 oass.IndexSchema.readSchema [testOverseerCol_shard3_replica1] Schema name=test
[junit4] 2> 618920 T3431 oass.IndexSchema.readSchema [testOverseerCol_shard2_replica1] Schema name=test
[junit4] 2> 618932 T3444 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 618945 T3444 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 618954 T3352 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 618954 T3352 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '.\org.apache.solr.cloud.OverseerRolesTest-controljetty-1391843653570\testOverseerCol_shard3_replica2\'
[junit4] 2> 619086 T3431 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619087 T3431 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619089 T3431 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 619100 T3431 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 619103 T3431 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 619126 T3404 oass.IndexSchema.readSchema [testOverseerCol_shard2_replica2] Schema name=test
[junit4] 2> 619173 T3376 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619174 T3376 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619176 T3376 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 619183 T3376 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 619186 T3376 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 619204 T3446 oascc.ZkStateReader.readConfigName path=/collections/testOverseerCol configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 619204 T3446 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty6-1391843665518\testOverseerCol_shard4_replica2\'
[junit4] 2> 619126 T3416 oass.IndexSchema.readSchema [testOverseerCol_shard1_replica2] Schema name=test
[junit4] 2> 619291 T3404 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619292 T3404 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619295 T3404 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 619301 T3404 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 619302 T3404 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 619323 T3388 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 619339 T3388 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 619346 T3444 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 619356 T3444 oass.IndexSchema.readSchema [testOverseerCol_shard1_replica1] Schema name=test
[junit4] 2> 619430 T3416 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619430 T3416 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619433 T3416 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 619440 T3416 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 619442 T3416 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 619458 T3352 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 619473 T3352 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 619484 T3388 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 619494 T3388 oass.IndexSchema.readSchema [testOverseerCol_shard4_replica1] Schema name=test
[junit4] 2> 619537 T3444 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619537 T3444 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619540 T3444 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 619545 T3444 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 619549 T3444 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 619565 T3446 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_47
[junit4] 2> 619581 T3446 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 619592 T3352 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 619602 T3352 oass.IndexSchema.readSchema [testOverseerCol_shard3_replica2] Schema name=test
[junit4] 2> 619684 T3388 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619685 T3388 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619687 T3388 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 619694 T3388 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 619696 T3388 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 619711 T3446 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 619722 T3446 oass.IndexSchema.readSchema [testOverseerCol_shard4_replica2] Schema name=test
[junit4] 2> 619793 T3352 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619795 T3352 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619796 T3352 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 619804 T3352 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 619806 T3352 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 619886 T3431 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 619905 T3431 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 619905 T3446 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619907 T3446 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead.
[junit4] 2> 619909 T3446 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 619917 T3431 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 619923 T3446 oass.IndexSchema.readSchema default search field in schema is text
[junit4] 2> 619924 T3376 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 619926 T3446 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 619928 T3431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 619928 T3431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 619929 T3431 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json
[junit4] 2> 619930 T3404 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 619934 T3431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE
[junit4] 2> 619935 T3431 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING
[junit4] 2> 619937 T3431 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 619938 T3431 oasc.SolrCore.<init> [testOverseerCol_shard2_replica1] Opening new SolrCore at ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310\testOverseerCol_shard2_replica1\, dataDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\org.apache.solr.cloud.OverseerRolesTest-jetty5-1391843663310\testOverseerCol_shard2_replica1\data\
[junit4] 2> 619938 T3431 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@af1184
[jun
[...truncated too long message...]
nt.getChildren(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:92)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 630213 T3451 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 629131 T3437 oasc.LeaderElector$1.process WARN org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1468)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:257)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:92)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 630217 T3437 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 629019 T3423 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 628925 T3409 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 628833 T3395 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 2> 630218 T3395 oasc.LeaderElector$1.process WARN org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /overseer_elect/election
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.getChildren(ZooKeeper.java:1468)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:257)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:254)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:92)
[junit4] 2> at org.apache.solr.cloud.LeaderElector.access$000(LeaderElector.java:55)
[junit4] 2> at org.apache.solr.cloud.LeaderElector$1.process(LeaderElector.java:137)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:519)
[junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:495)
[junit4] 2>
[junit4] 2> 628743 T3381 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK
[junit4] 1> client port:0.0.0.0/0.0.0.0:0
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=OverseerRolesTest -Dtests.method=testDistribSearch -Dtests.seed=6276BE3555ED57FC -Dtests.slow=true -Dtests.locale=ar_IQ -Dtests.timezone=Africa/Malabo -Dtests.file.encoding=US-ASCII
[junit4] ERROR 27.0s | OverseerRolesTest.testDistribSearch <<<
[junit4] > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=3533, name=Overseer-91215865666928654-127.0.0.1:63773_-n_0000000036, state=RUNNABLE, group=Overseer collection creation process.]
[junit4] > at __randomizedtesting.SeedInfo.seed([6276BE3555ED57FC:E390302D22B237C0]:0)
[junit4] > Caused by: org.apache.solr.common.cloud.ZooKeeperException:
[junit4] > at __randomizedtesting.SeedInfo.seed([6276BE3555ED57FC]:0)
[junit4] > at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:209)
[junit4] > at java.lang.Thread.run(Thread.java:744)
[junit4] > Caused by: org.apache.zookeeper.KeeperException$NoNodeException: KeeperErrorCode = NoNode for /overseer/collection-queue-work/qn-0000000004
[junit4] > at org.apache.zookeeper.KeeperException.create(KeeperException.java:111)
[junit4] > at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] > at org.apache.zookeeper.ZooKeeper.delete(ZooKeeper.java:873)
[junit4] > at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:174)
[junit4] > at org.apache.solr.common.cloud.SolrZkClient$2.execute(SolrZkClient.java:171)
[junit4] > at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:73)
[junit4] > at org.apache.solr.common.cloud.SolrZkClient.delete(SolrZkClient.java:171)
[junit4] > at org.apache.solr.cloud.DistributedQueue.remove(DistributedQueue.java:193)
[junit4] > at org.apache.solr.cloud.OverseerCollectionProcessor.run(OverseerCollectionProcessor.java:200)
[junit4] > ... 1 more
[junit4] 2> 630232 T3339 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene46: {}, docValues:{}, sim=DefaultSimilarity, locale=ar_IQ, timezone=Africa/Malabo
[junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0 (32-bit)/cpus=2,threads=7,free=98713072,total=260308992
[junit4] 2> NOTE: All tests run in this JVM: [TestHashPartitioner, DirectSolrSpellCheckerTest, CustomCollectionTest, TestHighFrequencyDictionaryFactory, TestXIncludeConfig, TestJmxMonitoredMap, TestStressVersions, TestMergePolicyConfig, PluginInfoTest, JsonLoaderTest, TestFieldResource, CoreMergeIndexesAdminHandlerTest, TermsComponentTest, EnumFieldTest, HdfsDirectoryTest, ExternalFileFieldSortTest, CircularListTest, TestQueryUtils, LukeRequestHandlerTest, SliceStateTest, HdfsBasicDistributedZkTest, DistributedTermsComponentTest, SystemInfoHandlerTest, TestTrie, TestCollationKeyRangeQueries, RAMDirectoryFactoryTest, DateMathParserTest, TestSolrQueryParserResource, FastVectorHighlighterTest, TestLMDirichletSimilarityFactory, TestSerializedLuceneMatchVersion, TestCloudManagedSchemaAddField, TestCollapseQParserPlugin, SuggesterWFSTTest, TestSweetSpotSimilarityFactory, TestSystemIdResolver, TestFiltering, TestIndexSearcher, TestPartialUpdateDeduplication, AddSchemaFieldsUpdateProcessorFactoryTest, ReturnFieldsTest, ShardRoutingCustomTest, TriLevelCompositeIdRoutingTest, CollectionsAPIDistributedZkTest, TestPhraseSuggestions, TestCoreDiscovery, RequestHandlersTest, TestLuceneMatchVersion, TestNoOpRegenerator, TestSolrIndexConfig, DateFieldTest, TestSolrXmlPersistor, TestCloudManagedSchema, TestSearchPerf, TestRandomDVFaceting, ResourceLoaderTest, UpdateParamsTest, TestImplicitCoreProperties, CacheHeaderTest, TestLMJelinekMercerSimilarityFactory, TestDynamicFieldResource, TestSchemaSimilarityResource, TestAddFieldRealTimeGet, FieldAnalysisRequestHandlerTest, MinimalSchemaTest, NoCacheHeaderTest, DocValuesMissingTest, SuggesterTSTTest, TestAnalyzeInfixSuggestions, QueryElevationComponentTest, XmlUpdateRequestHandlerTest, ConnectionManagerTest, SuggesterTest, UpdateRequestProcessorFactoryTest, TestMaxScoreQueryParser, DeleteReplicaTest, OpenCloseCoreStressTest, TestRTGBase, TestGroupingSearch, DistanceFunctionTest, TestFieldTypeResource, TestSolrQueryParserDefaultOperatorResource, TestIndexingPerformance, BadCopyFieldTest, TestReplicationHandler, TestShardHandlerFactory, OverseerRolesTest]
[junit4] Completed in 27.00s, 1 test, 1 error <<< FAILURES!
[...truncated 836 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:459: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:439: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\extra-targets.xml:37: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:189: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:491: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1308: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:941: There were test failures: 358 suites, 1554 tests, 1 error, 40 ignored (12 assumptions)
Total time: 70 minutes 12 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.8.0-fcs-b128 -server -XX:+UseParallelGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure