Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/3429/ Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed. FAILED: org.apache.solr.common.cloud.TestCollectionStateWatchers.testDeletionsTriggerWatches Error Message: Error from server at https://127.0.0.1:63948/solr: Could not find collection : tobedeleted Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at https://127.0.0.1:63948/solr: Could not find collection : tobedeleted at __randomizedtesting.SeedInfo.seed([F39BE5D470426242:515A2D5BF221B42F]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:606) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:259) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:248) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:413) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:366) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1270) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1040) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:976) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:166) at org.apache.solr.common.cloud.TestCollectionStateWatchers.testDeletionsTriggerWatches(TestCollectionStateWatchers.java:252) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 13105 lines...] [junit4] Suite: org.apache.solr.common.cloud.TestCollectionStateWatchers [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/init-core-data-001 [junit4] 2> 136602 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) w/ MAC_OS_X supressed clientAuth [junit4] 2> 136605 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 136605 INFO (Thread-452) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 136605 INFO (Thread-452) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 136715 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:63900 [junit4] 2> 136715 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 136716 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136741 INFO (zkCallback-184-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2fa345cb name:ZooKeeperConnection Watcher:127.0.0.1:63900 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136741 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136742 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 136742 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml [junit4] 2> 136748 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/clusterprops.json [junit4] 2> 136772 INFO (jetty-launcher-183-thread-2) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 136773 INFO (jetty-launcher-183-thread-1) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 136773 INFO (jetty-launcher-183-thread-3) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 136777 INFO (jetty-launcher-183-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5e51af7c{/solr,null,AVAILABLE} [junit4] 2> 136777 INFO (jetty-launcher-183-thread-4) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 136779 INFO (jetty-launcher-183-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@a14f11a{/solr,null,AVAILABLE} [junit4] 2> 136781 INFO (jetty-launcher-183-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@73605ad7{/solr,null,AVAILABLE} [junit4] 2> 136783 INFO (jetty-launcher-183-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7159d50a{/solr,null,AVAILABLE} [junit4] 2> 136791 INFO (jetty-launcher-183-thread-2) [ ] o.e.j.s.ServerConnector Started ServerConnector@44c43475{SSL,[ssl, http/1.1]}{127.0.0.1:63902} [junit4] 2> 136791 INFO (jetty-launcher-183-thread-2) [ ] o.e.j.s.Server Started @144034ms [junit4] 2> 136791 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63902} [junit4] 2> 136791 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4554617c [junit4] 2> 136791 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node2' [junit4] 2> 136792 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 136792 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 136792 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 136793 INFO (jetty-launcher-183-thread-1) [ ] o.e.j.s.ServerConnector Started ServerConnector@17dc4c13{SSL,[ssl, http/1.1]}{127.0.0.1:63904} [junit4] 2> 136793 INFO (jetty-launcher-183-thread-1) [ ] o.e.j.s.Server Started @144035ms [junit4] 2> 136793 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63904} [junit4] 2> 136793 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4554617c [junit4] 2> 136793 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node1' [junit4] 2> 136793 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136793 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 136793 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 136794 INFO (jetty-launcher-183-thread-3) [ ] o.e.j.s.ServerConnector Started ServerConnector@400c7f1c{SSL,[ssl, http/1.1]}{127.0.0.1:63903} [junit4] 2> 136795 INFO (jetty-launcher-183-thread-3) [ ] o.e.j.s.Server Started @144037ms [junit4] 2> 136795 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63903} [junit4] 2> 136795 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4554617c [junit4] 2> 136795 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node3' [junit4] 2> 136795 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 136795 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 136795 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 136796 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 136796 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136798 INFO (jetty-launcher-183-thread-4) [ ] o.e.j.s.ServerConnector Started ServerConnector@59c92f97{SSL,[ssl, http/1.1]}{127.0.0.1:63905} [junit4] 2> 136798 INFO (jetty-launcher-183-thread-4) [ ] o.e.j.s.Server Started @144040ms [junit4] 2> 136798 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63905} [junit4] 2> 136799 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136799 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@4554617c [junit4] 2> 136799 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node4' [junit4] 2> 136799 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 136799 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 136800 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 136801 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136802 INFO (zkCallback-185-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@9c66e9c name:ZooKeeperConnection Watcher:127.0.0.1:63900/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136803 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136803 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 136803 INFO (zkCallback-186-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@287fa413 name:ZooKeeperConnection Watcher:127.0.0.1:63900/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136804 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136804 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 136806 INFO (zkCallback-187-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2813aa61 name:ZooKeeperConnection Watcher:127.0.0.1:63900/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136806 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136807 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 136807 INFO (zkCallback-188-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1e7e1b7b name:ZooKeeperConnection Watcher:127.0.0.1:63900/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136807 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136808 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 136808 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 136809 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 136809 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 136809 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 136824 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node3/. [junit4] 2> 136824 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.CoreContainer New CoreContainer 2020143985 [junit4] 2> 136824 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node3] [junit4] 2> 136824 WARN (jetty-launcher-183-thread-3) [ ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node3/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node3/lib [junit4] 2> 136825 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false, [junit4] 2> 136828 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node4/. [junit4] 2> 136829 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.CoreContainer New CoreContainer 1106317647 [junit4] 2> 136829 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node4] [junit4] 2> 136829 WARN (jetty-launcher-183-thread-4) [ ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node4/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node4/lib [junit4] 2> 136829 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false, [junit4] 2> 136830 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000 [junit4] 2> 136830 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 136830 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 136830 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63900/solr [junit4] 2> 136830 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 136830 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 136830 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000 [junit4] 2> 136830 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 136830 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 136831 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63900/solr [junit4] 2> 136831 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 136831 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 136831 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136833 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136836 INFO (zkCallback-194-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4ab03eb9 name:ZooKeeperConnection Watcher:127.0.0.1:63900 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136836 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136837 INFO (jetty-launcher-183-thread-4) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 136838 INFO (zkCallback-193-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5d058849 name:ZooKeeperConnection Watcher:127.0.0.1:63900 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136838 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136838 INFO (jetty-launcher-183-thread-3) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 136840 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node2/. [junit4] 2> 136840 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.CoreContainer New CoreContainer 1411112298 [junit4] 2> 136840 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node2] [junit4] 2> 136840 WARN (jetty-launcher-183-thread-2) [ ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node2/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node2/lib [junit4] 2> 136841 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false, [junit4] 2> 136842 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$13/2136988380@5e0e7e72 [junit4] 2> 136842 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1561ac8124e0005, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 136844 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136845 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000 [junit4] 2> 136845 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 136845 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 136845 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63900/solr [junit4] 2> 136845 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 136845 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 136846 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136846 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node1/. [junit4] 2> 136846 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.CoreContainer New CoreContainer 1741361779 [junit4] 2> 136846 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node1] [junit4] 2> 136849 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$13/2136988380@2eede1b0 [junit4] 2> 136849 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1561ac8124e0006, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 136849 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136851 INFO (zkCallback-198-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@76c3454a name:ZooKeeperConnection Watcher:127.0.0.1:63900 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136851 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136851 INFO (jetty-launcher-183-thread-2) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 136853 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2f545bcb name:ZooKeeperConnection Watcher:127.0.0.1:63900/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136853 INFO (zkCallback-195-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@b98d8ca name:ZooKeeperConnection Watcher:127.0.0.1:63900/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136853 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136853 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136855 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$13/2136988380@a3dc87a [junit4] 2> 136856 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136855 WARN (jetty-launcher-183-thread-1) [ ] o.a.s.c.CoreContainer Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node1/lib to classpath: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node1/lib [junit4] 2> 136856 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 136856 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 136857 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false, [junit4] 2> 136858 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@56c2a676 name:ZooKeeperConnection Watcher:127.0.0.1:63900/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136859 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136861 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 136861 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 136862 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 136867 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 136868 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 136869 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 136871 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 136871 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 136872 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 136875 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 136875 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 136875 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 136878 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 136878 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 136878 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 136880 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 136881 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 136880 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 136884 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.u.UpdateShardHandler Created UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&maxConnections=100000&maxConnectionsPerHost=100000 [junit4] 2> 136884 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 136884 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 136884 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63900/solr [junit4] 2> 136884 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 136884 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 136885 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 136887 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136889 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 136889 INFO (zkCallback-206-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@24469376 name:ZooKeeperConnection Watcher:127.0.0.1:63900 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136889 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136890 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 136890 INFO (jetty-launcher-183-thread-1) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 136896 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 136896 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 136897 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apache.solr.cloud.ZkController$$Lambda$13/2136988380@7afbfb31 [junit4] 2> 136899 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 136901 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@40930086 name:ZooKeeperConnection Watcher:127.0.0.1:63900/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 136901 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 136901 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 136902 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 136903 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 136904 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader Loaded cluster properties: {urlScheme=https} [junit4] 2> 136906 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 136907 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 136907 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader Loaded cluster properties: {urlScheme=https} [junit4] 2> 136909 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 136912 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 136913 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader Loaded cluster properties: {urlScheme=https} [junit4] 2> 136915 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 136915 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 136918 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 136919 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96293888637927431-127.0.0.1:63905_solr-n_0000000000 [junit4] 2> 136920 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:63905_solr [junit4] 2> 136920 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 136923 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 136925 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer Overseer (id=96293888637927431-127.0.0.1:63905_solr-n_0000000000) starting [junit4] 2> 136926 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 136927 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96293888637927433-127.0.0.1:63903_solr-n_0000000001 [junit4] 2> 136928 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader Loaded cluster properties: {urlScheme=https} [junit4] 2> 136929 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/96293888637927431-127.0.0.1:63905_solr-n_0000000000 to know if I could be the leader [junit4] 2> 136929 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 136930 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63903_solr [junit4] 2> 136930 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:63903_solr [junit4] 2> 136930 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 136933 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 136933 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 136933 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 136933 INFO (zkCallback-195-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 136935 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 136935 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 136935 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 136937 INFO (zkCallback-195-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 136937 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96293888637927434-127.0.0.1:63902_solr-n_0000000002 [junit4] 2> 136945 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 136950 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 136951 INFO (OverseerCollectionConfigSetProcessor-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 136952 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 136953 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:63905_solr as DOWN [junit4] 2> 136955 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (1) [junit4] 2> 136957 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63905_solr [junit4] 2> 136957 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:63905_solr [junit4] 2> 136959 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 136960 INFO (zkCallback-195-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 136960 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:63905_solr"} current state version: 0 [junit4] 2> 136960 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:63905_solr [junit4] 2> 136961 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 136961 INFO (zkCallback-195-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 136962 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 136963 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 136964 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 136959 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 136960 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 136964 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 136966 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node3/. [junit4] 2> 136967 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 136967 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 136969 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0 [junit4] 2> 136969 INFO (jetty-launcher-183-thread-3) [n:127.0.0.1:63903_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 136969 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/96293888637927436-127.0.0.1:63904_solr-n_0000000003 [junit4] 2> 136969 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/96293888637927433-127.0.0.1:63903_solr-n_0000000001 to know if I could be the leader [junit4] 2> 136971 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/96293888637927434-127.0.0.1:63902_solr-n_0000000002 to know if I could be the leader [junit4] 2> 136973 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:63904_solr as DOWN [junit4] 2> 136973 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.ZkController Publish node=127.0.0.1:63902_solr as DOWN [junit4] 2> 136977 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63904_solr [junit4] 2> 136977 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:63904_solr [junit4] 2> 136978 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:63904_solr"} current state version: 0 [junit4] 2> 136978 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:63904_solr [junit4] 2> 136981 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [2]) [junit4] 2> 136981 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [2]) [junit4] 2> 136981 INFO (zkCallback-195-thread-2-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [2]) [junit4] 2> 136982 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 136982 INFO (zkCallback-195-thread-2-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 136983 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 136984 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [2]) [junit4] 2> 136985 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 136986 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:63902_solr"} current state version: 0 [junit4] 2> 136986 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:63902_solr [junit4] 2> 136987 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63902_solr [junit4] 2> 136987 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:63902_solr [junit4] 2> 136990 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 136990 INFO (zkCallback-195-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 136990 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 136991 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 136991 INFO (zkCallback-195-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 136992 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 136992 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 136992 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 137003 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 137003 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 137004 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node4/. [junit4] 2> 137005 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 137007 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0 [junit4] 2> 137007 INFO (jetty-launcher-183-thread-4) [n:127.0.0.1:63905_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 137026 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 137026 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 137027 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node2/. [junit4] 2> 137028 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 137029 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0 [junit4] 2> 137029 INFO (jetty-launcher-183-thread-2) [n:127.0.0.1:63902_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 137038 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 137038 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 137039 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001/tempDir-001/node1/. [junit4] 2> 137040 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 137042 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.s.SolrDispatchFilter user.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0 [junit4] 2> 137042 INFO (jetty-launcher-183-thread-1) [n:127.0.0.1:63904_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 137043 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 137043 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 137046 INFO (zkCallback-209-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@4793b6a1 name:ZooKeeperConnection Watcher:127.0.0.1:63900 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 137046 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 137047 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 137053 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 137054 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 137057 INFO (zkCallback-212-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@15d1fc82 name:ZooKeeperConnection Watcher:127.0.0.1:63900/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 137057 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 137058 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 137058 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 137060 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.ZkStateReader Loaded cluster properties: {urlScheme=https} [junit4] 2> 137061 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 137066 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/config/schema-replication1.xml [junit4] 2> 137072 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/config/schema-sql.xml [junit4] 2> 137077 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/config/schema.xml [junit4] 2> 137082 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/config/solrconfig-managed-schema.xml [junit4] 2> 137086 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/config/solrconfig-slave1.xml [junit4] 2> 137090 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/config/solrconfig-sql.xml [junit4] 2> 137094 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/config/solrconfig.xml [junit4] 2> 137144 INFO (TEST-TestCollectionStateWatchers.testPredicateFailureTimesOut-seed#[F39BE5D470426242]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testPredicateFailureTimesOut [junit4] 2> 137144 INFO (TEST-TestCollectionStateWatchers.testPredicateFailureTimesOut-seed#[F39BE5D470426242]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 137145 INFO (TEST-TestCollectionStateWatchers.testPredicateFailureTimesOut-seed#[F39BE5D470426242]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 137148 INFO (zkCallback-213-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3c175fbd name:ZooKeeperConnection Watcher:127.0.0.1:63900 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 137148 INFO (TEST-TestCollectionStateWatchers.testPredicateFailureTimesOut-seed#[F39BE5D470426242]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 137149 INFO (TEST-TestCollectionStateWatchers.testPredicateFailureTimesOut-seed#[F39BE5D470426242]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 137163 INFO (TEST-TestCollectionStateWatchers.testPredicateFailureTimesOut-seed#[F39BE5D470426242]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [nosuchcollection] [junit4] 2> 138174 INFO (TEST-TestCollectionStateWatchers.testPredicateFailureTimesOut-seed#[F39BE5D470426242]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testPredicateFailureTimesOut [junit4] 2> 138232 INFO (TEST-TestCollectionStateWatchers.testSimpleCollectionWatch-seed#[F39BE5D470426242]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSimpleCollectionWatch [junit4] 2> 138233 INFO (TEST-TestCollectionStateWatchers.testSimpleCollectionWatch-seed#[F39BE5D470426242]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 138233 INFO (TEST-TestCollectionStateWatchers.testSimpleCollectionWatch-seed#[F39BE5D470426242]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 138237 INFO (zkCallback-214-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@d2ce7ef name:ZooKeeperConnection Watcher:127.0.0.1:63900 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 138237 INFO (TEST-TestCollectionStateWatchers.testSimpleCollectionWatch-seed#[F39BE5D470426242]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 138237 INFO (TEST-TestCollectionStateWatchers.testSimpleCollectionWatch-seed#[F39BE5D470426242]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 138302 INFO (qtp1419462430-1351) [n:127.0.0.1:63902_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params async=323454af-062e-496b-a92d-0206f5e10c10&replicationFactor=1&collection.configName=config&name=testcollection&action=CREATE&numShards=4&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 138307 INFO (qtp1419462430-1351) [n:127.0.0.1:63902_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=323454af-062e-496b-a92d-0206f5e10c10&replicationFactor=1&collection.configName=config&name=testcollection&action=CREATE&numShards=4&wt=javabin&version=2} status=0 QTime=5 [junit4] 2> 138309 INFO (OverseerCollectionConfigSetProcessor-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running/mn-323454af-062e-496b-a92d-0206f5e10c10 [junit4] 2> 138310 INFO (qtp1419462430-1352) [n:127.0.0.1:63902_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=323454af-062e-496b-a92d-0206f5e10c10&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 138313 INFO (qtp1419462430-1352) [n:127.0.0.1:63902_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=323454af-062e-496b-a92d-0206f5e10c10&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=3 [junit4] 2> 138314 INFO (OverseerCollectionConfigSetProcessor-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerTaskProcessor Overseer Collection Message Handler: Get the message id:/overseer/collection-queue-work/qn-0000000000 message:{ [junit4] 2> "name":"testcollection", [junit4] 2> "fromApi":"true", [junit4] 2> "replicationFactor":"1", [junit4] 2> "collection.configName":"config", [junit4] 2> "numShards":"4", [junit4] 2> "stateFormat":"2", [junit4] 2> "async":"323454af-062e-496b-a92d-0206f5e10c10", [junit4] 2> "operation":"create"} [junit4] 2> 138314 INFO (OverseerThreadFactory-674-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerCollectionMessageHandler OverseerCollectionMessageHandler.processMessage : create , { [junit4] 2> "name":"testcollection", [junit4] 2> "fromApi":"true", [junit4] 2> "replicationFactor":"1", [junit4] 2> "collection.configName":"config", [junit4] 2> "numShards":"4", [junit4] 2> "stateFormat":"2", [junit4] 2> "async":"323454af-062e-496b-a92d-0206f5e10c10", [junit4] 2> "operation":"create"} [junit4] 2> 138314 INFO (OverseerThreadFactory-674-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerCollectionMessageHandler Create collection testcollection [junit4] 2> 138315 INFO (OverseerThreadFactory-674-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerCollectionMessageHandler creating collections conf node /collections/testcollection [junit4] 2> 138316 INFO (OverseerThreadFactory-674-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.SolrZkClient makePath: /collections/testcollection [junit4] 2> 138319 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 138319 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 138319 INFO (zkCallback-212-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 138319 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 138319 INFO (zkCallback-195-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 138334 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "name":"testcollection", [junit4] 2> "fromApi":"true", [junit4] 2> "replicationFactor":"1", [junit4] 2> "collection.configName":"config", [junit4] 2> "numShards":"4", [junit4] 2> "stateFormat":"2", [junit4] 2> "async":"323454af-062e-496b-a92d-0206f5e10c10", [junit4] 2> "operation":"create"} current state version: 0 [junit4] 2> 138334 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.ClusterStateMutator building a new cName: testcollection [junit4] 2> 138342 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/testcollection/state.json [junit4] 2> 138435 INFO (OverseerThreadFactory-674-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating SolrCores for new collection testcollection, shardNames [shard1, shard2, shard3, shard4] , replicationFactor : 1 [junit4] 2> 138435 INFO (OverseerThreadFactory-674-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testcollection_shard4_replica1 as part of shard shard4 of collection testcollection on 127.0.0.1:63905_solr [junit4] 2> 138435 INFO (OverseerThreadFactory-674-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testcollection_shard2_replica1 as part of shard shard2 of collection testcollection on 127.0.0.1:63902_solr [junit4] 2> 138436 INFO (OverseerThreadFactory-674-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testcollection_shard1_replica1 as part of shard shard1 of collection testcollection on 127.0.0.1:63903_solr [junit4] 2> 138436 INFO (OverseerThreadFactory-674-thread-1-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.OverseerCollectionMessageHandler Creating core testcollection_shard3_replica1 as part of shard shard3 of collection testcollection on 127.0.0.1:63904_solr [junit4] 2> 138453 INFO (qtp1419462430-1348) [n:127.0.0.1:63902_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=323454af-062e-496b-a92d-0206f5e10c101688512819602440&qt=/admin/cores&collection.configName=config&name=testcollection_shard2_replica1&action=CREATE&numShards=4&collection=testcollection&shard=shard2&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 138454 INFO (parallelCoreAdminExecutor-679-thread-1-processing-n:127.0.0.1:63902_solr 323454af-062e-496b-a92d-0206f5e10c101688512819602440 CREATE) [n:127.0.0.1:63902_solr ] o.a.s.h.a.CoreAdminOperation core create command async=323454af-062e-496b-a92d-0206f5e10c101688512819602440&qt=/admin/cores&collection.configName=config&name=testcollection_shard2_replica1&action=CREATE&numShards=4&collection=testcollection&shard=shard2&wt=javabin&version=2 [junit4] 2> 138456 INFO (parallelCoreAdminExecutor-679-thread-1-processing-n:127.0.0.1:63902_solr 323454af-062e-496b-a92d-0206f5e10c101688512819602440 CREATE) [n:127.0.0.1:63902_solr ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=testcollection_shard2_replica1, collection.configName=config, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=testcollection, numShards=4, dataDir=data/, shard=shard2} [junit4] 2> 138468 INFO (parallelCoreAdminExecutor-679-thread-1-processing-n:127.0.0.1:63902_solr 323454af-062e-496b-a92d-0206f5e10c101688512819602440 CREATE) [n:127.0.0.1:63902_solr c:testcollection s:shard2 x:testcollection_shard2_replica1] o.a.s.c.ZkController publishing state=down [junit4] 2> 138498 INFO (qtp1002457782-1358) [n:127.0.0.1:63903_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=323454af-062e-496b-a92d-0206f5e10c101688512819985626&qt=/admin/cores&collection.configName=config&name=testcollection_shard1_replica1&action=CREATE&numShards=4&collection=testcollection&shard=shard1&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 138498 INFO (parallelCoreAdminExecutor-675-thread-1-processing-n:127.0.0.1:63903_solr 323454af-062e-496b-a92d-0206f5e10c101688512819985626 CREATE) [n:127.0.0.1:63903_solr ] o.a.s.h.a.CoreAdminOperation core create command async=323454af-062e-496b-a92d-0206f5e10c101688512819985626&qt=/admin/cores&collection.configName=config&name=testcollection_shard1_replica1&action=CREATE&numShards=4&collection=testcollection&shard=shard1&wt=javabin&version=2 [junit4] 2> 138499 INFO (parallelCoreAdminExecutor-679-thread-1-processing-n:127.0.0.1:63902_solr 323454af-062e-496b-a92d-0206f5e10c101688512819602440 CREATE) [n:127.0.0.1:63902_solr c:testcollection s:shard2 x:testcollection_shard2_replica1] o.a.s.c.ZkController Registering watch for collection testcollection [junit4] 2> 138500 INFO (qtp1098147091-1375) [n:127.0.0.1:63905_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=323454af-062e-496b-a92d-0206f5e10c101688512819014904&qt=/admin/cores&collection.configName=config&name=testcollection_shard4_replica1&action=CREATE&numShards=4&collection=testcollection&shard=shard4&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 138501 INFO (parallelCoreAdminExecutor-677-thread-1-processing-n:127.0.0.1:63905_solr 323454af-062e-496b-a92d-0206f5e10c101688512819014904 CREATE) [n:127.0.0.1:63905_solr ] o.a.s.h.a.CoreAdminOperation core create command async=323454af-062e-496b-a92d-0206f5e10c101688512819014904&qt=/admin/cores&collection.configName=config&name=testcollection_shard4_replica1&action=CREATE&numShards=4&collection=testcollection&shard=shard4&wt=javabin&version=2 [junit4] 2> 138502 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"testcollection_shard2_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:63902/solr";, [junit4] 2> "node_name":"127.0.0.1:63902_solr", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"testcollection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 138502 INFO (parallelCoreAdminExecutor-677-thread-1-processing-n:127.0.0.1:63905_solr 323454af-062e-496b-a92d-0206f5e10c101688512819014904 CREATE) [n:127.0.0.1:63905_solr ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=testcollection_shard4_replica1, collection.configName=config, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=testcollection, numShards=4, dataDir=data/, shard=shard4} [junit4] 2> 138502 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=4 message={ [junit4] 2> "core":"testcollection_shard2_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:63902/solr";, [junit4] 2> "node_name":"127.0.0.1:63902_solr", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"testcollection", [junit4] 2> "operation":"state"} [junit4] 2> 138503 INFO (qtp1723626395-1366) [n:127.0.0.1:63904_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=323454af-062e-496b-a92d-0206f5e10c101688512820293627&qt=/admin/cores&collection.configName=config&name=testcollection_shard3_replica1&action=CREATE&numShards=4&collection=testcollection&shard=shard3&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 138503 INFO (parallelCoreAdminExecutor-675-thread-1-processing-n:127.0.0.1:63903_solr 323454af-062e-496b-a92d-0206f5e10c101688512819985626 CREATE) [n:127.0.0.1:63903_solr ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=testcollection_shard1_replica1, collection.configName=config, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=testcollection, numShards=4, dataDir=data/, shard=shard1} [junit4] 2> 138504 INFO (parallelCoreAdminExecutor-681-thread-1-processing-n:127.0.0.1:63904_solr 323454af-062e-496b-a92d-0206f5e10c101688512820293627 CREATE) [n:127.0.0.1:63904_solr ] o.a.s.h.a.CoreAdminOperation core create command async=323454af-062e-496b-a92d-0206f5e10c101688512820293627&qt=/admin/cores&collection.configName=config&name=testcollection_shard3_replica1&action=CREATE&numShards=4&collection=testcollection&shard=shard3&wt=javabin&version=2 [junit4] 2> 138504 INFO (parallelCoreAdminExecutor-679-thread-1-processing-n:127.0.0.1:63902_solr 323454af-062e-496b-a92d-0206f5e10c101688512819602440 CREATE) [n:127.0.0.1:63902_solr c:testcollection s:shard2 x:testcollection_shard2_replica1] o.a.s.c.c.ZkStateReader Add data for [testcollection] ver [0] [junit4] 2> 138505 INFO (parallelCoreAdminExecutor-681-thread-1-processing-n:127.0.0.1:63904_solr 323454af-062e-496b-a92d-0206f5e10c101688512820293627 CREATE) [n:127.0.0.1:63904_solr ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=testcollection_shard3_replica1, collection.configName=config, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=testcollection, numShards=4, dataDir=data/, shard=shard3} [junit4] 2> 138505 INFO (parallelCoreAdminExecutor-679-thread-1-processing-n:127.0.0.1:63902_solr 323454af-062e-496b-a92d-0206f5e10c101688512819602440 CREATE) [n:127.0.0.1:63902_solr c:testcollection s:shard2 x:testcollection_shard2_replica1] o.a.s.c.ZkController look for our core node name [junit4] 2> 138506 INFO (parallelCoreAdminExecutor-677-thread-1-processing-n:127.0.0.1:63905_solr 323454af-062e-496b-a92d-0206f5e10c101688512819014904 CREATE) [n:127.0.0.1:63905_solr c:testcollection s:shard4 x:testcollection_shard4_replica1] o.a.s.c.ZkController publishing state=down [junit4] 2> 138506 INFO (parallelCoreAdminExecutor-675-thread-1-processing-n:127.0.0.1:63903_solr 323454af-062e-496b-a92d-0206f5e10c101688512819985626 CREATE) [n:127.0.0.1:63903_solr c:testcollection s:shard1 x:testcollection_shard1_replica1] o.a.s.c.ZkController publishing state=down [junit4] 2> 138509 INFO (parallelCoreAdminExecutor-681-thread-1-processing-n:127.0.0.1:63904_solr 323454af-062e-496b-a92d-0206f5e10c101688512820293627 CREATE) [n:127.0.0.1:63904_solr c:testcollection s:shard3 x:testcollection_shard3_replica1] o.a.s.c.ZkController publishing state=down [junit4] 2> 138510 INFO (qtp1002457782-1359) [n:127.0.0.1:63903_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 323454af-062e-496b-a92d-0206f5e10c101688512819985626 [junit4] 2> 138511 INFO (qtp1002457782-1359) [n:127.0.0.1:63903_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=323454af-062e-496b-a92d-0206f5e10c101688512819985626&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 138513 INFO (parallelCoreAdminExecutor-675-thread-1-processing-n:127.0.0.1:63903_solr 323454af-062e-496b-a92d-0206f5e10c101688512819985626 CREATE) [n:127.0.0.1:63903_solr c:testcollection s:shard1 x:testcollection_shard1_replica1] o.a.s.c.ZkController Registering watch for collection testcollection [junit4] 2> 138513 INFO (parallelCoreAdminExecutor-677-thread-1-processing-n:127.0.0.1:63905_solr 323454af-062e-496b-a92d-0206f5e10c101688512819014904 CREATE) [n:127.0.0.1:63905_solr c:testcollection s:shard4 x:testcollection_shard4_replica1] o.a.s.c.ZkController Registering watch for collection testcollection [junit4] 2> 138514 INFO (parallelCoreAdminExecutor-681-thread-1-processing-n:127.0.0.1:63904_solr 323454af-062e-496b-a92d-0206f5e10c101688512820293627 CREATE) [n:127.0.0.1:63904_solr c:testcollection s:shard3 x:testcollection_shard3_replica1] o.a.s.c.ZkController Registering watch for collection testcollection [junit4] 2> 138515 INFO (parallelCoreAdminExecutor-675-thread-1-processing-n:127.0.0.1:63903_solr 323454af-062e-496b-a92d-0206f5e10c101688512819985626 CREATE) [n:127.0.0.1:63903_solr c:testcollection s:shard1 x:testcollection_shard1_replica1] o.a.s.c.c.ZkStateReader Add data for [testcollection] ver [0] [junit4] 2> 138516 INFO (parallelCoreAdminExecutor-675-thread-1-processing-n:127.0.0.1:63903_solr 323454af-062e-496b-a92d-0206f5e10c101688512819985626 CREATE) [n:127.0.0.1:63903_solr c:testcollection s:shard1 x:testcollection_shard1_replica1] o.a.s.c.ZkController look for our core node name [junit4] 2> 138516 INFO (parallelCoreAdminExecutor-681-thread-1-processing-n:127.0.0.1:63904_solr 323454af-062e-496b-a92d-0206f5e10c101688512820293627 CREATE) [n:127.0.0.1:63904_solr c:testcollection s:shard3 x:testcollection_shard3_replica1] o.a.s.c.c.ZkStateReader Add data for [testcollection] ver [0] [junit4] 2> 138517 INFO (parallelCoreAdminExecutor-681-thread-1-processing-n:127.0.0.1:63904_solr 323454af-062e-496b-a92d-0206f5e10c101688512820293627 CREATE) [n:127.0.0.1:63904_solr c:testcollection s:shard3 x:testcollection_shard3_replica1] o.a.s.c.ZkController look for our core node name [junit4] 2> 138518 INFO (parallelCoreAdminExecutor-677-thread-1-processing-n:127.0.0.1:63905_solr 323454af-062e-496b-a92d-0206f5e10c101688512819014904 CREATE) [n:127.0.0.1:63905_solr c:testcollection s:shard4 x:testcollection_shard4_replica1] o.a.s.c.c.ZkStateReader Add data for [testcollection] ver [0] [junit4] 2> 138518 INFO (parallelCoreAdminExecutor-677-thread-1-processing-n:127.0.0.1:63905_solr 323454af-062e-496b-a92d-0206f5e10c101688512819014904 CREATE) [n:127.0.0.1:63905_solr c:testcollection s:shard4 x:testcollection_shard4_replica1] o.a.s.c.ZkController look for our core node name [junit4] 2> 138518 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = { [junit4] 2> "core":"testcollection_shard4_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:63905/solr";, [junit4] 2> "node_name":"127.0.0.1:63905_solr", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard4", [junit4] 2> "collection":"testcollection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 138518 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=4 message={ [junit4] 2> "core":"testcollection_shard4_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:63905/solr";, [junit4] 2> "node_name":"127.0.0.1:63905_solr", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard4", [junit4] 2> "collection":"testcollection", [junit4] 2> "operation":"state"} [junit4] 2> 138522 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer processMessage: queueSize: 3, message = { [junit4] 2> "core":"testcollection_shard1_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:63903/solr";, [junit4] 2> "node_name":"127.0.0.1:63903_solr", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"testcollection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 138522 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=4 message={ [junit4] 2> "core":"testcollection_shard1_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:63903/solr";, [junit4] 2> "node_name":"127.0.0.1:63903_solr", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"testcollection", [junit4] 2> "operation":"state"} [junit4] 2> 138529 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.Overseer processMessage: queueSize: 2, message = { [junit4] 2> "core":"testcollection_shard3_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:63904/solr";, [junit4] 2> "node_name":"127.0.0.1:63904_solr", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard3", [junit4] 2> "collection":"testcollection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 138530 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.ReplicaMutator Update state numShards=4 message={ [junit4] 2> "core":"testcollection_shard3_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:63904/solr";, [junit4] 2> "node_name":"127.0.0.1:63904_solr", [junit4] 2> "numShards":"4", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard3", [junit4] 2> "collection":"testcollection", [junit4] 2> "operation":"state"} [junit4] 2> 138638 INFO (OverseerStateUpdate-96293888637927431-127.0.0.1:63905_solr-n_0000000000) [n:127.0.0.1:63905_solr ] o.a.s.c.o.ZkStateWriter going to update_collection /collections/testcollection/state.json version: 0 [junit4] 2> 138640 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testcollection/state.json] for collection [testcollection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 138640 INFO (zkCallback-200-thread-1-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testcollection/state.json] for collection [testcollection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 138641 INFO (zkCallback-207-thread-1-processing-n:127.0.0.1:63904_solr) [n:127.0.0.1:63904_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testcollection/state.json] for collection [testcollection] has occurred [...truncated too long message...] drenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 191165 WARN (zkCallback-232-thread-2-processing-n:127.0.0.1:63902_solr) [n:127.0.0.1:63902_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 191165 ERROR (TEST-TestCollectionStateWatchers.testWaitForStateWatcherIsRetainedOnPredicateFailure-seed#[F39BE5D470426242]-EventThread) [n:127.0.0.1:63902_solr ] o.a.z.ClientCnxn Error while calling watcher [junit4] 2> java.util.concurrent.RejectedExecutionException: Task org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$$Lambda$9/1052913382@13fb0aa4 rejected from org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor@56f986bf[Shutting down, pool size = 2, active threads = 1, queued tasks = 0, completed tasks = 21] [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2047) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.reject(ThreadPoolExecutor.java:823) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.execute(ThreadPoolExecutor.java:1369) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.execute(ExecutorUtil.java:214) [junit4] 2> at java.util.concurrent.AbstractExecutorService.submit(AbstractExecutorService.java:112) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$3.process(SolrZkClient.java:266) [junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.processEvent(ClientCnxn.java:522) [junit4] 2> at org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:498) [junit4] 2> 191163 INFO (zkCallback-226-thread-2-processing-n:127.0.0.1:63948_solr) [n:127.0.0.1:63948_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 191166 WARN (zkCallback-226-thread-2-processing-n:127.0.0.1:63948_solr) [n:127.0.0.1:63948_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 191163 INFO (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3]) [junit4] 2> 191166 WARN (zkCallback-199-thread-1-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 191166 INFO (jetty-launcher-183-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7ce6d683{/solr,null,UNAVAILABLE} [junit4] 2> 191162 INFO (zkCallback-195-thread-6-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [4]) [junit4] 2> 191167 WARN (zkCallback-195-thread-6-processing-n:127.0.0.1:63905_solr) [n:127.0.0.1:63905_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes] [junit4] 2> 191165 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1561ac8124e001a, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 191167 INFO (jetty-launcher-183-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2401a593{/solr,null,UNAVAILABLE} [junit4] 2> 191167 INFO (jetty-launcher-183-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7159d50a{/solr,null,UNAVAILABLE} [junit4] 2> 191167 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x1561ac8124e0009, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 192666 WARN (zkCallback-199-thread-2-processing-n:127.0.0.1:63903_solr) [n:127.0.0.1:63903_solr ] o.a.s.c.LeaderElector [junit4] 2> 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:1472) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:331) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$6.execute(SolrZkClient.java:328) [junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.getChildren(SolrZkClient.java:328) [junit4] 2> at org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:105) [junit4] 2> at org.apache.solr.cloud.LeaderElector.access$200(LeaderElector.java:56) [junit4] 2> at org.apache.solr.cloud.LeaderElector$ElectionWatcher.process(LeaderElector.java:348) [junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$3.lambda$process$0(SolrZkClient.java:266) [junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> 192667 INFO (jetty-launcher-183-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@a14f11a{/solr,null,UNAVAILABLE} [junit4] 2> 192672 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63900 63900 [junit4] 2> 192773 INFO (Thread-452) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63900 63900 [junit4] 2> 196632 WARN (Thread-452) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 8 /solr/aliases.json [junit4] 2> 7 /solr/security.json [junit4] 2> 7 /solr/configs/config [junit4] 2> 3 /solr/collections/stateformat1/state.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 14 /solr/collections/falsepredicate/state.json [junit4] 2> 12 /solr/collections/waitforstate/state.json [junit4] 2> 8 /solr/clusterprops.json [junit4] 2> 8 /solr/clusterstate.json [junit4] 2> 7 /solr/collections/testcollection/state.json [junit4] 2> 3 /solr/collections/stateformat1/state.json [junit4] 2> 2 /solr/collections/currentstate/state.json [junit4] 2> 2 /solr/overseer_elect/election/96293888637927433-127.0.0.1:63903_solr-n_0000000001 [junit4] 2> 2 /solr/collections/delayed/state.json [junit4] 2> 2 /solr/overseer_elect/election/96293888637927434-127.0.0.1:63902_solr-n_0000000002 [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 68 /solr/overseer/queue [junit4] 2> 33 /solr/overseer/collection-queue-work [junit4] 2> 14 /solr/overseer/queue-work [junit4] 2> 8 /solr/collections [junit4] 2> 5 /solr/live_nodes [junit4] 2> [junit4] 2> 196632 INFO (SUITE-TestCollectionStateWatchers-seed#[F39BE5D470426242]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J0/temp/solr.common.cloud.TestCollectionStateWatchers_F39BE5D470426242-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=1404, maxMBSortInHeap=5.9971304111694606, sim=RandomSimilarity(queryNorm=true): {}, locale=nn-NO, timezone=SystemV/MST7MDT [junit4] 2> NOTE: Mac OS X 10.11.5 x86_64/Oracle Corporation 1.8.0_92 (64-bit)/cpus=3,threads=1,free=276696416,total=412090368 [junit4] 2> NOTE: All tests run in this JVM: [CloudSolrClientTest, JettyWebappTest, LBHttpSolrClientBuilderTest, TestSolrProperties, TestClusteringResponse, SolrDocumentTest, ShardParamsTest, ModifiableSolrParamsTest, JDBCStreamTest, TestHash, TestRetryUtil, TestXMLEscaping, SchemaTest, CloudSolrClientBuilderTest, SolrExampleEmbeddedTest, NamedListTest, TestCollectionAdminRequest, TestSolrJErrorHandling, TermsResponseTest, TestCollectionStateWatchers] [junit4] Completed [65/83 (1!)] on J0 in 60.06s, 9 tests, 1 error <<< FAILURES! [...truncated 59477 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
