Build: http://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/17077/ Java: 32bit/jdk1.8.0_92 -server -XX:+UseSerialGC
1 tests failed. FAILED: org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay Error Message: Could not find collection : c1 Stack Trace: org.apache.solr.common.SolrException: Could not find collection : c1 at __randomizedtesting.SeedInfo.seed([C054B4FC15AFAE2A:BFCA03797CCD83A0]:0) at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129) at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:51) 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 11501 lines...] [junit4] Suite: org.apache.solr.cloud.overseer.ZkStateReaderTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_C054B4FC15AFAE2A-001/init-core-data-001 [junit4] 2> 985551 INFO (SUITE-ZkStateReaderTest-seed#[C054B4FC15AFAE2A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 985554 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 985554 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 985554 INFO (Thread-2185) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 985554 INFO (Thread-2185) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 985655 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer start zk server on port:37848 [junit4] 2> 985655 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 985655 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 985657 INFO (zkCallback-1069-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1753612 name:ZooKeeperConnection Watcher:127.0.0.1:37848 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 985657 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 985657 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 985658 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 985658 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 985659 INFO (zkCallback-1070-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5831d9 name:ZooKeeperConnection Watcher:127.0.0.1:37848 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 985659 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 985659 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 985659 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 985686 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 985687 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 985688 INFO (zkCallback-1071-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1d7850d name:ZooKeeperConnection Watcher:127.0.0.1:37848/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 985688 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 985689 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 985689 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 985690 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 985691 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 985691 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 985693 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 985695 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 985695 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 985697 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 985697 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 985698 INFO (zkCallback-1071-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 985699 INFO (zkCallback-1071-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 985751 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 985757 INFO (zkCallback-1071-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 985805 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37848 37848 [junit4] 2> 990853 INFO (Thread-2185) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37848 37848 [junit4] 2> 990853 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelayLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelayLazy [junit4] 2> 990855 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testWatchedCollectionCreation [junit4] 2> 990857 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 990857 INFO (Thread-2186) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 990857 INFO (Thread-2186) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 990957 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer start zk server on port:43954 [junit4] 2> 990957 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 990957 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 990960 INFO (zkCallback-1073-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@2374f2 name:ZooKeeperConnection Watcher:127.0.0.1:43954 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 990960 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 990960 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 990961 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 0x15592b56a8d0000, 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> 990961 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 990962 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 990963 INFO (zkCallback-1074-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@19986b1 name:ZooKeeperConnection Watcher:127.0.0.1:43954 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 990963 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 990963 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 990963 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 990969 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 990970 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 990972 INFO (zkCallback-1075-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1146bba name:ZooKeeperConnection Watcher:127.0.0.1:43954/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 990977 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 990977 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 990979 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 990979 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 990980 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 990981 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 990982 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 990982 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 990982 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 990983 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 990984 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 990984 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 990986 INFO (zkCallback-1075-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 990987 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 990989 INFO (zkCallback-1075-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0]) [junit4] 2> 990989 INFO (zkCallback-1075-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 991040 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43954 43954 [junit4] 2> 996165 INFO (Thread-2186) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43954 43954 [junit4] 2> 996166 INFO (TEST-ZkStateReaderTest.testWatchedCollectionCreation-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testWatchedCollectionCreation [junit4] 2> 996167 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithTimeDelay [junit4] 2> 996168 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 996168 INFO (Thread-2187) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 996168 INFO (Thread-2187) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 996269 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer start zk server on port:38835 [junit4] 2> 996269 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 996269 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 996271 INFO (zkCallback-1077-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1b84a85 name:ZooKeeperConnection Watcher:127.0.0.1:38835 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 996271 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 996271 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 996272 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 996272 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 996273 INFO (zkCallback-1078-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@159f957 name:ZooKeeperConnection Watcher:127.0.0.1:38835 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 996273 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 996273 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 996273 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 996275 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 996275 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 996276 INFO (zkCallback-1079-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@11f8b8a name:ZooKeeperConnection Watcher:127.0.0.1:38835/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 996276 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 996276 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 996276 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 996277 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 996278 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 996279 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 996281 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 996282 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 996282 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 996283 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 996284 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 996284 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 996285 INFO (zkCallback-1079-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 996286 INFO (zkCallback-1079-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 996287 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 996287 INFO (zkCallback-1079-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 996287 INFO (zkCallback-1079-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0]) [junit4] 2> 996288 INFO (zkCallback-1079-thread-2) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 996293 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38835 38835 [junit4] 2> 1001336 INFO (Thread-2187) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:38835 38835 [junit4] 2> 1001850 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithTimeDelay-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithTimeDelay [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ZkStateReaderTest -Dtests.method=testStateFormatUpdateWithTimeDelay -Dtests.seed=C054B4FC15AFAE2A -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=da -Dtests.timezone=Europe/Rome -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] ERROR 5.69s J1 | ZkStateReaderTest.testStateFormatUpdateWithTimeDelay <<< [junit4] > Throwable #1: org.apache.solr.common.SolrException: Could not find collection : c1 [junit4] > at __randomizedtesting.SeedInfo.seed([C054B4FC15AFAE2A:BFCA03797CCD83A0]:0) [junit4] > at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:192) [junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdate(ZkStateReaderTest.java:129) [junit4] > at org.apache.solr.cloud.overseer.ZkStateReaderTest.testStateFormatUpdateWithTimeDelay(ZkStateReaderTest.java:51) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 1001854 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 1001854 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1001854 INFO (Thread-2188) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1001854 INFO (Thread-2188) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1001954 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer start zk server on port:37319 [junit4] 2> 1001954 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1001955 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1001956 INFO (zkCallback-1081-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@12adcd name:ZooKeeperConnection Watcher:127.0.0.1:37319 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1001956 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1001957 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1001957 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1001957 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1001958 INFO (zkCallback-1082-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@debd44 name:ZooKeeperConnection Watcher:127.0.0.1:37319 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1001958 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1001958 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1001958 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1001959 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1001960 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1001960 INFO (zkCallback-1083-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@18fc153 name:ZooKeeperConnection Watcher:127.0.0.1:37319/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1001960 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1001960 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1001961 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1001961 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 1001961 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1001962 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1001962 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1001962 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1001962 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 1001963 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1001963 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 1001963 INFO (zkCallback-1083-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 1001964 INFO (zkCallback-1083-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 1001964 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 1001965 INFO (zkCallback-1083-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 1001965 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37319 37319 [junit4] 2> 1002010 INFO (Thread-2188) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:37319 37319 [junit4] 2> 1002010 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefreshLazy-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefreshLazy [junit4] 2> 1002012 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testStateFormatUpdateWithExplicitRefresh [junit4] 2> 1002013 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1002013 INFO (Thread-2189) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1002013 INFO (Thread-2189) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1002113 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer start zk server on port:34169 [junit4] 2> 1002113 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1002113 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1002115 INFO (zkCallback-1085-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@6debd3 name:ZooKeeperConnection Watcher:127.0.0.1:34169 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1002115 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1002115 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1002116 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1002116 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1002117 INFO (zkCallback-1086-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1afd415 name:ZooKeeperConnection Watcher:127.0.0.1:34169 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1002117 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1002117 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1002117 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1002118 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1002118 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1002119 INFO (zkCallback-1087-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@8adc9f name:ZooKeeperConnection Watcher:127.0.0.1:34169/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1002119 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1002119 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1002119 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1002119 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 1002120 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1002120 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1002120 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1002121 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1002121 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 1002121 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1002121 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Deleting data for [c1] [junit4] 2> 1002122 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 1002122 INFO (zkCallback-1087-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 1002122 INFO (zkCallback-1087-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 1002122 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 1002123 INFO (zkCallback-1087-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeCreated path:/collections/c1/state.json] for collection [c1] has occurred - updating... (live nodes size: [0]) [junit4] 2> 1002123 INFO (zkCallback-1087-thread-1) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 1002123 INFO (zkCallback-1087-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [0]) [junit4] 2> 1002124 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34169 34169 [junit4] 2> 1012146 INFO (Thread-2189) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:34169 34169 [junit4] 2> 1012146 INFO (TEST-ZkStateReaderTest.testStateFormatUpdateWithExplicitRefresh-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testStateFormatUpdateWithExplicitRefresh [junit4] 2> 1012148 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testExternalCollectionWatchedNotWatched [junit4] 2> 1012149 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1012149 INFO (Thread-2190) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1012149 INFO (Thread-2190) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1012249 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer start zk server on port:43545 [junit4] 2> 1012249 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1012249 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1012256 INFO (zkCallback-1089-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@b89079 name:ZooKeeperConnection Watcher:127.0.0.1:43545 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1012256 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1012256 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1012257 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1012257 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1012258 INFO (zkCallback-1090-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@132feab name:ZooKeeperConnection Watcher:127.0.0.1:43545 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1012258 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1012258 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1012258 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 1012259 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 1012259 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 1012260 INFO (zkCallback-1091-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@777044 name:ZooKeeperConnection Watcher:127.0.0.1:43545/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 1012260 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 1012260 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 1012260 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 1012261 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 1012261 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 1012262 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 1012262 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 1012263 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 1012263 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties [junit4] 2> 1012263 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 1012265 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/c1 [junit4] 2> 1012265 INFO (zkCallback-1091-thread-1) [ ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 1012265 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.o.ZkStateWriter going to create_collection /collections/c1/state.json [junit4] 2> 1012266 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.c.ZkStateReader Add data for [c1] ver [0] [junit4] 2> 1012267 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43545 43545 [junit4] 2> 1012388 INFO (Thread-2190) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:43545 43545 [junit4] 2> 1012388 INFO (TEST-ZkStateReaderTest.testExternalCollectionWatchedNotWatched-seed#[C054B4FC15AFAE2A]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testExternalCollectionWatchedNotWatched [junit4] 2> 1012389 INFO (SUITE-ZkStateReaderTest-seed#[C054B4FC15AFAE2A]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.overseer.ZkStateReaderTest_C054B4FC15AFAE2A-001 [junit4] 2> Jun 27, 2016 4:33:52 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {}, docValues:{}, maxPointsInLeafNode=1478, maxMBSortInHeap=7.398071417337526, sim=RandomSimilarity(queryNorm=false,coord=no): {}, locale=da, timezone=Europe/Rome [junit4] 2> NOTE: Linux 4.4.0-24-generic i386/Oracle Corporation 1.8.0_92 (32-bit)/cpus=12,threads=1,free=295430520,total=518979584 [junit4] 2> NOTE: All tests run in this JVM: [DocValuesTest, TestUpdate, TestBinaryResponseWriter, FileUtilsTest, BasicFunctionalityTest, ParsingFieldUpdateProcessorsTest, TestSolrCoreProperties, NotRequiredUniqueKeyTest, OutOfBoxZkACLAndCredentialsProvidersTest, ZkControllerTest, SharedFSAutoReplicaFailoverUtilsTest, ChaosMonkeyNothingIsSafeTest, SoftAutoCommitTest, TestOverriddenPrefixQueryForCustomFieldType, SolrIndexSplitterTest, RestartWhileUpdatingTest, TestFieldCacheSortRandom, DistributedQueryComponentOptimizationTest, TestFieldTypeCollectionResource, TestDynamicFieldResource, TestCoreContainer, TestUniqueKeyFieldResource, TestFastLRUCache, TestCloudDeleteByQuery, AddSchemaFieldsUpdateProcessorFactoryTest, DistribCursorPagingTest, TestSubQueryTransformerDistrib, TestSmileRequest, ConvertedLegacyTest, HdfsBasicDistributedZkTest, TestOrdValues, HighlighterTest, TestNRTOpen, BitVectorTest, TriLevelCompositeIdRoutingTest, SaslZkACLProviderTest, SpellCheckComponentTest, SolrInfoMBeanTest, TestDFRSimilarityFactory, SolrCmdDistributorTest, TestQueryUtils, UniqFieldsUpdateProcessorFactoryTest, GraphQueryTest, SpellPossibilityIteratorTest, TestWordDelimiterFilterFactory, TestImplicitCoreProperties, TestReplicaProperties, ChaosMonkeySafeLeaderTest, HttpPartitionTest, SpatialRPTFieldTypeTest, TestPartialUpdateDeduplication, AliasIntegrationTest, TestBackupRepositoryFactory, TestTolerantUpdateProcessorCloud, DistributedFacetPivotSmallTest, SpatialFilterTest, TestGraphTermsQParserPlugin, TermVectorComponentTest, WordBreakSolrSpellCheckerTest, TestLegacyFieldCache, TestSha256AuthenticationProvider, TestMiniSolrCloudClusterBase, TestChildDocTransformer, TestObjectReleaseTracker, TestSystemIdResolver, TestGeoJSONResponseWriter, TestStandardQParsers, HdfsWriteToMultipleCollectionsTest, ShardRoutingTest, RuleEngineTest, MinimalSchemaTest, HdfsThreadLeakTest, TestDistributedStatsComponentCardinality, TestBM25SimilarityFactory, TestOnReconnectListenerSupport, DistributedMLTComponentTest, TolerantUpdateProcessorTest, TestCopyFieldCollectionResource, CoreMergeIndexesAdminHandlerTest, TestSlowCompositeReaderWrapper, DistributedIntervalFacetingTest, TestExceedMaxTermLength, ShardRoutingCustomTest, TestCustomSort, TestRestManager, AnalyticsQueryTest, TestHashPartitioner, MBeansHandlerTest, TestJsonRequest, CollectionsAPIDistributedZkTest, HdfsCollectionsAPIDistributedZkTest, TermsComponentTest, ZkStateReaderTest] [junit4] Completed [309/616 (1!)] on J1 in 27.61s, 6 tests, 1 error <<< FAILURES! [...truncated 1032 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:740: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:684: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:59: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build.xml:233: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/common-build.xml:530: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1427: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:984: There were test failures: 616 suites (10 ignored), 2590 tests, 1 error, 117 ignored (72 assumptions) [seed: C054B4FC15AFAE2A] Total time: 68 minutes 2 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org