Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4226/ Java: 64bit/jdk1.8.0_20-ea-b23 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed. FAILED: org.apache.solr.schema.TestCloudSchemaless.testDistribSearch Error Message: Timeout occured while waiting response from server at: https://127.0.0.1:64978/collection1 Stack Trace: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: https://127.0.0.1:64978/collection1 at __randomizedtesting.SeedInfo.seed([1B8F8D519FD8E272:9A690349E887824E]:0) at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:561) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:210) at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:206) at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:124) at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:68) at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:54) at org.apache.solr.schema.TestCloudSchemaless.doTest(TestCloudSchemaless.java:140) at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:865) at sun.reflect.GeneratedMethodAccessor49.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:483) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) 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:43) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.read(SocketInputStream.java:150) at java.net.SocketInputStream.read(SocketInputStream.java:121) at sun.security.ssl.InputRecord.readFully(InputRecord.java:465) at sun.security.ssl.InputRecord.read(InputRecord.java:503) at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:954) at sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:911) at sun.security.ssl.AppInputStream.read(AppInputStream.java:105) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:260) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:271) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:123) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:682) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:486) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:863) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:106) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:57) at org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrServer.java:449) ... 46 more Build Log: [...truncated 12007 lines...] [junit4] Suite: org.apache.solr.schema.TestCloudSchemaless [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\init-core-data-001 [junit4] 2> 6383925 T18935 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (true) and clientAuth (false) [junit4] 2> 6383925 T18935 oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext system property: / [junit4] 2> 6383933 T18935 oas.SolrTestCaseJ4.setUp ###Starting testDistribSearch [junit4] 2> 6383933 T18935 oasc.ZkTestServer.run STARTING ZK TEST SERVER [junit4] 1> client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 6383936 T18936 oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server [junit4] 2> 6384054 T18935 oasc.ZkTestServer.run start zk server on port:64956 [junit4] 2> 6384056 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6384062 T18942 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@3287ad50 name:ZooKeeperConnection Watcher:127.0.0.1:64956 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6384063 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6384063 T18935 oascc.SolrZkClient.makePath makePath: /solr [junit4] 2> 6384071 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6384073 T18944 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@47b135dc name:ZooKeeperConnection Watcher:127.0.0.1:64956/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6384073 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6384073 T18935 oascc.SolrZkClient.makePath makePath: /collections/collection1 [junit4] 2> 6384079 T18935 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards [junit4] 2> 6384083 T18935 oascc.SolrZkClient.makePath makePath: /collections/control_collection [junit4] 2> 6384087 T18935 oascc.SolrZkClient.makePath makePath: /collections/control_collection/shards [junit4] 2> 6384091 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-schemaless.xml to /configs/conf1/solrconfig.xml [junit4] 2> 6384092 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.xml [junit4] 2> 6384098 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema-add-schema-fields-update-processor.xml to /configs/conf1/schema.xml [junit4] 2> 6384099 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml [junit4] 2> 6384103 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 6384104 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 6384108 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 6384108 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/stopwords.txt [junit4] 2> 6384113 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 6384114 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/protwords.txt [junit4] 2> 6384117 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml to /configs/conf1/currency.xml [junit4] 2> 6384119 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/currency.xml [junit4] 2> 6384123 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 6384124 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 6384128 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 6384129 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 6384133 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 6384135 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 6384139 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 6384140 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 6384145 T18935 oasc.AbstractZkTestCase.putConfig put C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 6384146 T18935 oascc.SolrZkClient.makePath makePath: /configs/conf1/synonyms.txt [junit4] 2> 6384152 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6384154 T18946 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@5ea531fc name:ZooKeeperConnection Watcher:127.0.0.1:64956/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6384154 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6386521 T18935 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 6386532 T18935 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 6386548 T18935 oejs.AbstractConnector.doStart Started [email protected]:64966 [junit4] 2> 6386553 T18935 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 6386553 T18935 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 6386553 T18935 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002 [junit4] 2> 6386553 T18935 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\' [junit4] 2> 6386609 T18935 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\solr.xml [junit4] 2> 6386626 T18935 oasc.CoreContainer.<init> New CoreContainer 25848112 [junit4] 2> 6386626 T18935 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\] [junit4] 2> 6386628 T18935 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 6386628 T18935 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 6386628 T18935 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 6386628 T18935 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 6386628 T18935 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 6386628 T18935 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 6386630 T18935 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 6386630 T18935 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 6386630 T18935 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 6386635 T18935 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 6386639 T18935 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 6386639 T18935 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 6386639 T18935 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 6386639 T18935 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:64956/solr [junit4] 2> 6386642 T18935 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 6386644 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6386646 T18957 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@c03b16e name:ZooKeeperConnection Watcher:127.0.0.1:64956 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6386647 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6386650 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6386652 T18959 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@14c692d8 name:ZooKeeperConnection Watcher:127.0.0.1:64956/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6386652 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6386654 T18935 oascc.SolrZkClient.makePath makePath: /overseer/queue [junit4] 2> 6386660 T18935 oascc.SolrZkClient.makePath makePath: /overseer/collection-queue-work [junit4] 2> 6386666 T18935 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-running [junit4] 2> 6386671 T18935 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-completed [junit4] 2> 6386676 T18935 oascc.SolrZkClient.makePath makePath: /overseer/collection-map-failure [junit4] 2> 6386683 T18935 oascc.SolrZkClient.makePath makePath: /live_nodes [junit4] 2> 6386685 T18935 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64966_ [junit4] 2> 6386686 T18935 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:64966_ [junit4] 2> 6386691 T18935 oascc.SolrZkClient.makePath makePath: /overseer_elect [junit4] 2> 6386693 T18935 oascc.SolrZkClient.makePath makePath: /overseer_elect/election [junit4] 2> 6386700 T18935 oasc.OverseerElectionContext.runLeaderProcess I am going to be the leader 127.0.0.1:64966_ [junit4] 2> 6386700 T18935 oascc.SolrZkClient.makePath makePath: /overseer_elect/leader [junit4] 2> 6386703 T18935 oasc.Overseer.start Overseer (id=92211586716991492-127.0.0.1:64966_-n_0000000000) starting [junit4] 2> 6386708 T18935 oascc.SolrZkClient.makePath makePath: /overseer/queue-work [junit4] 2> 6386724 T18961 oasc.OverseerCollectionProcessor.run Process current queue of collection creations [junit4] 2> 6386725 T18935 oascc.SolrZkClient.makePath makePath: /clusterstate.json [junit4] 2> 6386728 T18935 oascc.SolrZkClient.makePath makePath: /aliases.json [junit4] 2> 6386731 T18935 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 6386735 T18960 oasc.Overseer$ClusterStateUpdater.run Starting to work on the main queue [junit4] 2> 6386742 T18962 oasc.ZkController.publish publishing core=collection1 state=down collection=control_collection [junit4] 2> 6386742 T18962 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6386743 T18962 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 6386744 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6386747 T18960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6386748 T18960 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=1 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:64966";, [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:64966_", [junit4] 2> "shard":null, [junit4] 2> "collection":"control_collection", [junit4] 2> "numShards":"1", [junit4] 2> "core_node_name":null} [junit4] 2> 6386748 T18960 oasc.Overseer$ClusterStateUpdater.createCollection Create collection control_collection with shards [shard1] [junit4] 2> 6386748 T18960 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard1 [junit4] 2> 6386752 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6386753 T18963 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 6387911 T18962 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 6387911 T18962 oasc.ZkController.createCollectionZkNode Check for collection zkNode:control_collection [junit4] 2> 6387912 T18962 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 6387913 T18962 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 6387915 T18962 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6387916 T18962 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\collection1\' [junit4] 2> 6387919 T18962 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001/tempDir-002/collection1/lib/.svn/' to classloader [junit4] 2> 6387920 T18962 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001/tempDir-002/collection1/lib/classes/' to classloader [junit4] 2> 6387921 T18962 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001/tempDir-002/collection1/lib/README' to classloader [junit4] 2> 6387968 T18962 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0 [junit4] 2> 6387977 T18962 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 6387980 T18962 oass.ManagedIndexSchemaFactory.create The schema is configured as managed, but managed schema resource managed-schema not found - loading non-managed schema schema.xml instead [junit4] 2> 6387981 T18962 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 6387985 T18962 oass.IndexSchema.readSchema [collection1] Schema name=add-schema-fields-update-processor [junit4] 2> 6387998 T18962 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 6387999 T18962 oass.ManagedIndexSchema.persistManagedSchemaToZooKeeper Created and persisted managed schema znode at /configs/conf1/managed-schema [junit4] 2> 6388002 T18962 oascc.SolrZkClient.makePath makePath: /configs/conf1/schema.xml.bak [junit4] 2> 6388008 T18962 oass.ManagedIndexSchemaFactory.zkUgradeToManagedSchema After upgrading to managed schema in ZooKeeper, renamed the non-managed schema /configs/conf1/schema.xml to /configs/conf1/schema.xml.bak [junit4] 2> 6388009 T18962 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection control_collection [junit4] 2> 6388009 T18962 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory [junit4] 2> 6388010 T18962 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\collection1\data\ [junit4] 2> 6388010 T18962 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 6388011 T18962 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\collection1\data [junit4] 2> 6388013 T18962 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\collection1\data\index/ [junit4] 2> 6388014 T18962 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 6388014 T18962 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\collection1\data\index [junit4] 2> 6388015 T18962 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=507030941, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 6388023 T18962 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30a2b4e6; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6388023 T18962 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6388025 T18962 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "add-unknown-fields-to-the-schema" [junit4] 2> 6388118 T18962 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 6388118 T18962 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6388119 T18962 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6388119 T18962 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6388119 T18962 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6388120 T18962 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 6388120 T18962 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 6388120 T18962 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 6388121 T18962 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6388121 T18962 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 6388121 T18962 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 6388121 T18962 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 6388130 T18962 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6388132 T18962 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6388134 T18962 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6388136 T18962 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6388137 T18962 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6388140 T18962 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 6388140 T18962 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 6388142 T18962 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=10, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 6388144 T18962 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-002\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30a2b4e6; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6388144 T18962 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6388145 T18962 oass.SolrIndexSearcher.<init> Opening Searcher@1346a630[collection1] main [junit4] 2> 6388145 T18962 oascc.ZkStateReader.readConfigName Load collection config from:/collections/control_collection [junit4] 2> 6388147 T18962 oascc.ZkStateReader.readConfigName path=/collections/control_collection configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6388147 T18962 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 6388148 T18962 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 6388149 T18962 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 6388149 T18962 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6388151 T18962 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 6388151 T18962 oasr.ManagedResourceStorage.load Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6388153 T18962 oascc.SolrZkClient.makePath makePath: /configs/conf1/_rest_managed.json [junit4] 2> 6388157 T18962 oasr.ManagedResourceStorage$ZooKeeperStorageIO$1.close Wrote 38 bytes to new znode /configs/conf1/_rest_managed.json [junit4] 2> 6388157 T18962 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6388157 T18962 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 6388159 T18962 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ... [junit4] 2> 6388161 T18962 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 6388161 T18964 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1346a630[collection1] main{UninvertingDirectoryReader()} [junit4] 2> 6388163 T18967 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:64966 collection:control_collection shard:shard1 [junit4] 2> 6388163 T18935 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0 [junit4] 2> 6388164 T18935 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 6388165 T18967 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leader_elect/shard1/election [junit4] 2> 6388176 T18967 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard1 [junit4] 2> 6388180 T18967 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 6388180 T18967 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C3561 name=collection1 org.apache.solr.core.SolrCore@61bc5fcf url=https://127.0.0.1:64966/collection1 node=127.0.0.1:64966_ C3561_STATE=coll:control_collection core:collection1 props:{state=down, base_url=https://127.0.0.1:64966, core=collection1, node_name=127.0.0.1:64966_} [junit4] 2> 6388180 T18967 C3561 P64966 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:64966/collection1/ [junit4] 2> 6388180 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6388180 T18967 C3561 P64966 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 6388181 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6388181 T18967 C3561 P64966 oasc.SyncStrategy.syncToMe https://127.0.0.1:64966/collection1/ has no replicas [junit4] 2> 6388183 T18967 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:64966/collection1/ shard1 [junit4] 2> 6388183 T18967 oascc.SolrZkClient.makePath makePath: /collections/control_collection/leaders/shard1 [junit4] 2> 6388185 T18960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6388186 T18969 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@471fb995 name:ZooKeeperConnection Watcher:127.0.0.1:64956/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6388186 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6388188 T18935 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 6388192 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6388194 T18935 oasc.ChaosMonkey.monkeyLog monkey: init - expire sessions:false cause connection loss:false [junit4] 2> 6388196 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6388201 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6388323 T18963 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 6388324 T18970 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 6388375 T18967 oasc.ZkController.register We are https://127.0.0.1:64966/collection1/ and leader is https://127.0.0.1:64966/collection1/ [junit4] 2> 6388375 T18967 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:64966 [junit4] 2> 6388375 T18967 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 6388375 T18967 oasc.ZkController.publish publishing core=collection1 state=active collection=control_collection [junit4] 2> 6388375 T18967 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6388379 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6388379 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6388380 T18967 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6388382 T18960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6388383 T18960 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"active", [junit4] 2> "base_url":"https://127.0.0.1:64966";, [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:64966_", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"control_collection", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":"core_node1"} [junit4] 2> 6388386 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6388387 T18971 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6388507 T18971 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 6388507 T18970 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 1) [junit4] 2> 6390576 T18935 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 1 [junit4] 2> 6390578 T18935 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 6390588 T18935 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 6390591 T18935 oejs.AbstractConnector.doStart Started [email protected]:64978 [junit4] 2> 6390596 T18935 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 6390596 T18935 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 6390596 T18935 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003 [junit4] 2> 6390596 T18935 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\' [junit4] 2> 6390648 T18935 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\solr.xml [junit4] 2> 6390691 T18935 oasc.CoreContainer.<init> New CoreContainer 949401593 [junit4] 2> 6390691 T18935 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\] [junit4] 2> 6390692 T18935 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 6390692 T18935 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 6390692 T18935 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 6390692 T18935 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 6390692 T18935 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 6390692 T18935 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 6390692 T18935 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 6390692 T18935 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 6390694 T18935 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 6390699 T18935 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 6390703 T18935 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 6390703 T18935 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 6390703 T18935 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 6390703 T18935 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:64956/solr [junit4] 2> 6390703 T18935 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 6390708 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6390711 T18982 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@6cf63bd8 name:ZooKeeperConnection Watcher:127.0.0.1:64956 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6390712 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6390716 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6390717 T18984 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@7b9d26ef name:ZooKeeperConnection Watcher:127.0.0.1:64956/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6390717 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6390731 T18935 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 6392023 T18935 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64978_ [junit4] 2> 6392024 T18935 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:64978_ [junit4] 2> 6392046 T18986 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1 [junit4] 2> 6392047 T18986 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6392048 T18971 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6392048 T18986 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 6392048 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6392049 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6392052 T18960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6392054 T18960 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:64978";, [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:64978_", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":null} [junit4] 2> 6392054 T18960 oasc.Overseer$ClusterStateUpdater.createCollection Create collection collection1 with shards [shard1, shard2, shard3, shard4] [junit4] 2> 6392054 T18960 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard2 [junit4] 2> 6392058 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6392061 T18970 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 6392061 T18987 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 6392061 T18985 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 6393333 T18986 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 6393333 T18986 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1 [junit4] 2> 6393334 T18986 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 6393335 T18986 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 6393337 T18986 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6393338 T18986 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\collection1\' [junit4] 2> 6393342 T18986 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001/tempDir-003/collection1/lib/.svn/' to classloader [junit4] 2> 6393343 T18986 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001/tempDir-003/collection1/lib/classes/' to classloader [junit4] 2> 6393345 T18986 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001/tempDir-003/collection1/lib/README' to classloader [junit4] 2> 6393393 T18986 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0 [junit4] 2> 6393403 T18986 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 6393407 T18986 oass.IndexSchema.readSchema Reading Solr Schema from managed-schema [junit4] 2> 6393411 T18986 oass.IndexSchema.readSchema [collection1] Schema name=add-schema-fields-update-processor [junit4] 2> 6393423 T18986 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 6393424 T18986 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 6393424 T18986 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory [junit4] 2> 6393427 T18986 oasc.SolrCore.<init> [collection1] Opening new SolrCore at ..\..\..\..\..\..\..\..\..\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\collection1\data\ [junit4] 2> 6393427 T18986 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 6393427 T18986 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\collection1\data [junit4] 2> 6393428 T18986 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\collection1\data\index/ [junit4] 2> 6393429 T18986 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 6393431 T18986 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\collection1\data\index [junit4] 2> 6393433 T18986 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=507030941, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 6393465 T18986 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5912b859; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6393465 T18986 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6393468 T18986 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "add-unknown-fields-to-the-schema" [junit4] 2> 6393471 T18986 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 6393471 T18986 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6393472 T18986 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6393472 T18986 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6393472 T18986 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6393472 T18986 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 6393475 T18986 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 6393475 T18986 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 6393475 T18986 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6393475 T18986 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 6393475 T18986 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 6393475 T18986 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 6393483 T18986 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6393487 T18986 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6393488 T18986 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6393490 T18986 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6393492 T18986 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6393496 T18986 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 6393496 T18986 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 6393498 T18986 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=10, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 6393498 T18986 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-003\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5912b859; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6393498 T18986 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6393500 T18986 oass.SolrIndexSearcher.<init> Opening Searcher@1d0bfe4e[collection1] main [junit4] 2> 6393501 T18986 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 6393503 T18986 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6393505 T18986 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 6393506 T18986 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 6393506 T18986 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 6393506 T18986 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6393508 T18986 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes from znode /configs/conf1/_rest_managed.json [junit4] 2> 6393510 T18986 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6393510 T18986 oasr.ManagedResource.reloadFromStorage Loaded initArgs {} for /rest/managed [junit4] 2> 6393510 T18986 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 6393511 T18986 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ... [junit4] 2> 6393513 T18986 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 6393513 T18988 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1d0bfe4e[collection1] main{UninvertingDirectoryReader()} [junit4] 2> 6393515 T18991 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:64978 collection:collection1 shard:shard2 [junit4] 2> 6393516 T18935 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0 [junit4] 2> 6393517 T18935 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 6393520 T18991 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard2/election [junit4] 2> 6393537 T18991 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard2 [junit4] 2> 6393542 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6393544 T18991 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 6393544 T18991 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C3562 name=collection1 org.apache.solr.core.SolrCore@3d918485 url=https://127.0.0.1:64978/collection1 node=127.0.0.1:64978_ C3562_STATE=coll:collection1 core:collection1 props:{state=down, base_url=https://127.0.0.1:64978, core=collection1, node_name=127.0.0.1:64978_} [junit4] 2> 6393544 T18991 C3562 P64978 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:64978/collection1/ [junit4] 2> 6393544 T18991 C3562 P64978 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 6393544 T18991 C3562 P64978 oasc.SyncStrategy.syncToMe https://127.0.0.1:64978/collection1/ has no replicas [junit4] 2> 6393544 T18991 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:64978/collection1/ shard2 [junit4] 2> 6393547 T18991 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard2 [junit4] 2> 6393557 T18960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6393574 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6393577 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6393590 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6393725 T18985 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 6393727 T18987 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 6393728 T18970 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 6393782 T18991 oasc.ZkController.register We are https://127.0.0.1:64978/collection1/ and leader is https://127.0.0.1:64978/collection1/ [junit4] 2> 6393782 T18991 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:64978 [junit4] 2> 6393782 T18991 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 6393782 T18991 oasc.ZkController.publish publishing core=collection1 state=active collection=collection1 [junit4] 2> 6393782 T18991 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6393787 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6393788 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6393788 T18971 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6393789 T18991 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6393794 T18960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6393797 T18960 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"active", [junit4] 2> "base_url":"https://127.0.0.1:64978";, [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:64978_", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":"core_node1"} [junit4] 2> 6393805 T18971 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6393939 T18970 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 6393940 T18971 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 6393940 T18985 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 2) [junit4] 2> 6396391 T18935 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 2 [junit4] 2> 6396391 T18935 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 6396403 T18935 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 6396407 T18935 oejs.AbstractConnector.doStart Started [email protected]:64987 [junit4] 2> 6396413 T18935 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 6396414 T18935 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 6396414 T18935 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004 [junit4] 2> 6396414 T18935 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\' [junit4] 2> 6396471 T18935 oasc.ConfigSolr.fromFile Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\solr.xml [junit4] 2> 6396487 T18935 oasc.CoreContainer.<init> New CoreContainer 1141964318 [junit4] 2> 6396488 T18935 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\] [junit4] 2> 6396489 T18935 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 6396489 T18935 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 6396489 T18935 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 6396491 T18935 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 6396491 T18935 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 6396491 T18935 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 6396492 T18935 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 6396492 T18935 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 6396493 T18935 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 6396498 T18935 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=false [junit4] 2> 6396503 T18935 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 6396503 T18935 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 6396504 T18935 oasc.CoreContainer.load Host Name: 127.0.0.1 [junit4] 2> 6396504 T18935 oasc.ZkContainer.initZooKeeper Zookeeper client=127.0.0.1:64956/solr [junit4] 2> 6396504 T18935 oasc.ZkController.checkChrootPath zkHost includes chroot [junit4] 2> 6396509 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6396511 T19002 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@2fc2a09e name:ZooKeeperConnection Watcher:127.0.0.1:64956 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6396511 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6396513 T18937 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x14799f316710008, 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> [junit4] 2> 6396514 T18935 oascc.ConnectionManager.waitForConnected Waiting for client to connect to ZooKeeper [junit4] 2> 6396516 T19004 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@382eaa1 name:ZooKeeperConnection Watcher:127.0.0.1:64956/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 6396517 T18935 oascc.ConnectionManager.waitForConnected Client is connected to ZooKeeper [junit4] 2> 6396531 T18935 oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating cluster state from ZooKeeper... [junit4] 2> 6397824 T18935 oasc.ZkController.createEphemeralLiveNode Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64987_ [junit4] 2> 6397827 T18935 oascc.SolrZkClient.makePath makePath: /live_nodes/127.0.0.1:64987_ [junit4] 2> 6397851 T19006 oasc.ZkController.publish publishing core=collection1 state=down collection=collection1 [junit4] 2> 6397852 T19006 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6397853 T19006 oasc.ZkController.waitForCoreNodeName look for our core node name [junit4] 2> 6397853 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6397853 T18971 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6397853 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6397858 T18960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6397859 T18960 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:64987";, [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:64987_", [junit4] 2> "shard":null, [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":null} [junit4] 2> 6397859 T18960 oasc.Overseer$ClusterStateUpdater.updateState Collection already exists with numShards=4 [junit4] 2> 6397859 T18960 oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to shard shard=shard3 [junit4] 2> 6397864 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6397866 T18963 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6397867 T19005 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6397867 T18970 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6397867 T18985 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6399138 T19006 oasc.ZkController.waitForShardId waiting to find shard id in clusterstate for collection1 [junit4] 2> 6399138 T19006 oasc.ZkController.createCollectionZkNode Check for collection zkNode:collection1 [junit4] 2> 6399139 T19006 oasc.ZkController.createCollectionZkNode Collection zkNode exists [junit4] 2> 6399139 T19006 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 6399142 T19006 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6399142 T19006 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\collection1\' [junit4] 2> 6399145 T19006 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001/tempDir-004/collection1/lib/.svn/' to classloader [junit4] 2> 6399147 T19006 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001/tempDir-004/collection1/lib/classes/' to classloader [junit4] 2> 6399149 T19006 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test/J0/temp/solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001/tempDir-004/collection1/lib/README' to classloader [junit4] 2> 6399198 T19006 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_5_0 [junit4] 2> 6399209 T19006 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 6399212 T19006 oass.IndexSchema.readSchema Reading Solr Schema from managed-schema [junit4] 2> 6399216 T19006 oass.IndexSchema.readSchema [collection1] Schema name=add-schema-fields-update-processor [junit4] 2> 6399229 T19006 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 6399231 T19006 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from collection collection1 [junit4] 2> 6399231 T19006 oasc.SolrCore.initDirectoryFactory solr.NRTCachingDirectoryFactory [junit4] 2> 6399232 T19006 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\collection1\data\ [junit4] 2> 6399233 T19006 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 6399233 T19006 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\collection1\data [junit4] 2> 6399234 T19006 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\collection1\data\index/ [junit4] 2> 6399236 T19006 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\collection1\data\index' doesn't exist. Creating new index... [junit4] 2> 6399236 T19006 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\collection1\data\index [junit4] 2> 6399238 T19006 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=507030941, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] [junit4] 2> 6399247 T19006 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@874dbbb; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6399248 T19006 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6399251 T19006 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "add-unknown-fields-to-the-schema" [junit4] 2> 6399253 T19006 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 6399253 T19006 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6399253 T19006 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6399254 T19006 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6399254 T19006 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6399254 T19006 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 6399256 T19006 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 6399256 T19006 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 6399256 T19006 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 6399257 T19006 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 6399257 T19006 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 6399257 T19006 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 6399267 T19006 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6399270 T19006 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6399271 T19006 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6399273 T19006 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6399276 T19006 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 6399278 T19006 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 6399280 T19006 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 6399281 T19006 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=10, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 6399282 T19006 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=NRTCachingDirectory(MMapDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.schema.TestCloudSchemaless-1B8F8D519FD8E272-001\tempDir-004\collection1\data\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@874dbbb; maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1} [junit4] 2> 6399283 T19006 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 6399283 T19006 oass.SolrIndexSearcher.<init> Opening Searcher@602bb0e1[collection1] main [junit4] 2> 6399283 T19006 oascc.ZkStateReader.readConfigName Load collection config from:/collections/collection1 [junit4] 2> 6399286 T19006 oascc.ZkStateReader.readConfigName path=/collections/collection1 configName=conf1 specified config exists in ZooKeeper [junit4] 2> 6399286 T19006 oasr.ManagedResourceStorage.newStorageIO Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 6399287 T19006 oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 6399288 T19006 oasr.RestManager.init Initializing RestManager with initArgs: {} [junit4] 2> 6399288 T19006 oasr.ManagedResourceStorage.load Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6399291 T19006 oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream Read 38 bytes from znode /configs/conf1/_rest_managed.json [junit4] 2> 6399291 T19006 oasr.ManagedResourceStorage.load Loaded LinkedHashMap at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 6399291 T19006 oasr.ManagedResource.reloadFromStorage Loaded initArgs {} for /rest/managed [junit4] 2> 6399291 T19006 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 6399292 T19006 oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper watch for the managed schema at /configs/conf1/managed-schema ... [junit4] 2> 6399295 T19006 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 6399295 T19007 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@602bb0e1[collection1] main{UninvertingDirectoryReader()} [junit4] 2> 6399297 T19010 oasc.ZkController.register Register replica - core:collection1 address:https://127.0.0.1:64987 collection:collection1 shard:shard3 [junit4] 2> 6399297 T18935 oass.SolrDispatchFilter.init user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0 [junit4] 2> 6399297 T18935 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 6399298 T19010 oascc.SolrZkClient.makePath makePath: /collections/collection1/leader_elect/shard3/election [junit4] 2> 6399317 T19010 oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader process for shard shard3 [junit4] 2> 6399321 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6399322 T19010 oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough replicas found to continue. [junit4] 2> 6399322 T19010 oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader - try and sync [junit4] 2> ASYNC NEW_CORE C3563 name=collection1 org.apache.solr.core.SolrCore@183d3610 url=https://127.0.0.1:64987/collection1 node=127.0.0.1:64987_ C3563_STATE=coll:collection1 core:collection1 props:{state=down, base_url=https://127.0.0.1:64987, core=collection1, node_name=127.0.0.1:64987_} [junit4] 2> 6399322 T19010 C3563 P64987 oasc.SyncStrategy.sync Sync replicas to https://127.0.0.1:64987/collection1/ [junit4] 2> 6399322 T19010 C3563 P64987 oasc.SyncStrategy.syncReplicas Sync Success - now sync replicas to me [junit4] 2> 6399322 T19010 C3563 P64987 oasc.SyncStrategy.syncToMe https://127.0.0.1:64987/collection1/ has no replicas [junit4] 2> 6399322 T19010 oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: https://127.0.0.1:64987/collection1/ shard3 [junit4] 2> 6399323 T19010 oascc.SolrZkClient.makePath makePath: /collections/collection1/leaders/shard3 [junit4] 2> 6399329 T18960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6399337 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6399347 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6399483 T18985 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6399484 T19005 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6399484 T18970 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6399485 T18963 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6399543 T19010 oasc.ZkController.register We are https://127.0.0.1:64987/collection1/ and leader is https://127.0.0.1:64987/collection1/ [junit4] 2> 6399543 T19010 oasc.ZkController.register No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:64987 [junit4] 2> 6399543 T19010 oasc.ZkController.checkRecovery I am the leader, no recovery necessary [junit4] 2> 6399543 T19010 oasc.ZkController.publish publishing core=collection1 state=active collection=collection1 [junit4] 2> 6399543 T19010 oasc.ZkController.publish numShards not found on descriptor - reading it from system property [junit4] 2> 6399547 T18963 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6399547 T18971 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6399548 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6399548 T19010 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6399553 T18960 oascc.ZkStateReader.updateClusterState Updating cloud state from ZooKeeper... [junit4] 2> 6399554 T18960 oasc.Overseer$ClusterStateUpdater.updateState Update state numShards=4 message={ [junit4] 2> "operation":"state", [junit4] 2> "state":"active", [junit4] 2> "base_url":"https://127.0.0.1:64987";, [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "node_name":"127.0.0.1:64987_", [junit4] 2> "shard":"shard3", [junit4] 2> "collection":"collection1", [junit4] 2> "numShards":"4", [junit4] 2> "core_node_name":"core_node2"} [junit4] 2> 6399558 T18987 oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired on path: /overseer/queue state: SyncConnected type NodeChildrenChanged [junit4] 2> 6399692 T19005 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6399692 T18987 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6399694 T18985 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6399694 T18970 oascc.ZkStateReader$2.process A cluster state change: WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred - updating... (live nodes size: 3) [junit4] 2> 6401869 T18935 oasc.AbstractFullDistribZkTestBase.createJettys create jetty 3 [junit4] 2> 6401870 T18935 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 6401880 T18935 oejus.SslContextFactory.doStart Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] [junit4] 2> 6401884 T18935 oejs.AbstractConnector.doStart Started [email protected]:64996 [junit4] 2> 6401889 T18935 oass.SolrDispatchFilter.init SolrDispatchFilter.init() [junit4] 2> 6401889 T18935 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 6401889 T18935 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\temp\solr.schema.TestCloudSche [...truncated too long message...] VectorHighlighterTest, ZkControllerTest, LoggingHandlerTest, SchemaVersionSpecificBehaviorTest, DirectSolrConnectionTest, JSONWriterTest, TestMultiCoreConfBootstrap, HighlighterMaxOffsetTest, CurrencyFieldOpenExchangeTest, TestSolrQueryParser, TestSolrQueryParserDefaultOperatorResource, TestFieldTypeCollectionResource, PathHierarchyTokenizerFactoryTest, TestCopyFieldCollectionResource, TestSort, TestWordDelimiterFilterFactory, TestDynamicFieldCollectionResource, TestSolrIndexConfig, ChaosMonkeySafeLeaderTest, HdfsBasicDistributedZkTest, FullSolrCloudDistribCmdsTest, IndexSchemaRuntimeFieldTest, AnalyticsQueryTest, AnalysisAfterCoreReloadTest, TestFreeTextSuggestions, OverseerTest, TestHashPartitioner, TestConfigSets, TestDistributedMissingSort, CachingDirectoryFactoryTest, AliasIntegrationTest, TestCloudManagedSchemaConcurrent, TestManagedSchemaFieldResource, TestDocSet, TestBM25SimilarityFactory, SpellCheckComponentTest, DistribCursorPagingTest, TestStressRecovery, TestSolrXMLSerializer, BinaryUpdateRequestHandlerTest, PolyFieldTest, CSVRequestHandlerTest, TestManagedResourceStorage, TestSweetSpotSimilarityFactory, HighlighterConfigTest, BJQParserTest, HdfsChaosMonkeySafeLeaderTest, TestSolr4Spatial2, TestFastOutputStream, PreAnalyzedUpdateProcessorTest, LeaderElectionTest, TestSolrQueryParserResource, TestUpdate, CacheHeaderTest, TestCollationFieldDocValues, HdfsSyncSliceTest, TestJmxMonitoredMap, UniqFieldsUpdateProcessorFactoryTest, QueryElevationComponentTest, URLClassifyProcessorTest, QueryFacetTest, TestCustomSort, TestCodecSupport, TestFieldCollectionResource, AssignTest, RequiredFieldsTest, SpellCheckCollatorTest, SpatialFilterTest, MergeStrategyTest, DefaultValueUpdateProcessorTest, TestSurroundQueryParser, StatsComponentTest, BadCopyFieldTest, TestRandomFaceting, StandardRequestHandlerTest, OverseerRolesTest, DisMaxRequestHandlerTest, DistributedQueryComponentCustomSortTest, TestSolrCoreProperties, UnloadDistributedZkTest, SolrXmlInZkTest, SyncSliceTest, TestExceedMaxTermLength, PeerSyncTest, CollectionsAPIDistributedZkTest, TestStressLucene, TestBlendedInfixSuggestions, ExternalFileFieldSortTest, TestLRUCache, AbstractAnalyticsStatsTest, TestOrdValues, TestCoreContainer, TestRTGBase, SynonymTokenizerTest, DocumentAnalysisRequestHandlerTest, FieldFacetExtrasTest, TestNoOpRegenerator, TestPerFieldSimilarity, NumericFieldsTest, CustomCollectionTest, TestRecovery, TestExtendedDismaxParser, OpenCloseCoreStressTest, TestSchemaVersionResource, TestRemoteStreaming, PrimUtilsTest, TestUtils, TestDocBasedVersionConstraints, TestNRTOpen, TestImplicitCoreProperties, TestBinaryResponseWriter, HdfsWriteToMultipleCollectionsTest, TestReplicationHandlerBackup, ConvertedLegacyTest, ShowFileRequestHandlerTest, TestReloadAndDeleteDocs, DebugComponentTest, TestIntervalFaceting, TestSolrDeletionPolicy1, XsltUpdateRequestHandlerTest, DocValuesMultiTest, EchoParamsTest, TestQuerySenderListener, HttpPartitionTest, DistributedSpellCheckComponentTest, TestZkChroot, HdfsRecoveryZkTest, TestRestManager, BadIndexSchemaTest, TestCursorMarkWithoutUniqueKey, DistanceFunctionTest, TestFaceting, TestFieldSortValues, CursorPagingTest, TestFastWriter, TestPHPSerializedResponseWriter, CoreAdminRequestStatusTest, ResourceLoaderTest, TestOverriddenPrefixQueryForCustomFieldType, TestMaxScoreQueryParser, NoFacetTest, SolrIndexConfigTest, MultiThreadedOCPTest, HdfsLockFactoryTest, SimplePostToolTest, DeleteShardTest, TestArbitraryIndexDir, SliceStateTest, RangeFacetTest, TestOmitPositions, TestJmxIntegration, SampleTest, TestSolrXmlPersistor, TestElisionMultitermQuery, ConnectionManagerTest, OverseerCollectionProcessorTest, TestCSVLoader, CoreAdminHandlerTest, FieldFacetTest, DeleteReplicaTest, TestExpandComponent, ScriptEngineTest, TestClassNameShortening, BasicZkTest, TestFuzzyAnalyzedSuggestions, TestFieldTypeResource, TimeZoneUtilsTest, FieldAnalysisRequestHandlerTest, TestMissingGroups, TestStandardQParsers, LegacyHTMLStripCharFilterTest, TestBadConfig, ClusterStateUpdateTest, TestDistributedGrouping, TestSuggestSpellingConverter, TestCloudInspectUtil, ResponseLogComponentTest, TestLazyCores, JsonLoaderTest, SpellPossibilityIteratorTest, SolrIndexSplitterTest, UUIDUpdateProcessorFallbackTest, DistributedExpandComponentTest, TestSimpleQParserPlugin, TestLeaderElectionZkExpiry, BasicDistributedZkTest, BasicDistributedZk2Test, LeaderElectionIntegrationTest, ShardRoutingTest, RecoveryZkTest, TestReplicationHandler, ZkSolrClientTest, ZkCLITest, ShardRoutingCustomTest, TestDistributedSearch, AutoCommitTest, TermVectorComponentDistributedTest, TestRealTimeGet, TestStressReorder, TestJoin, TestReload, TestStressVersions, HardAutoCommitTest, DistributedTermsComponentTest, TestRangeQuery, SimpleFacetsTest, TestSolr4Spatial, SolrCoreTest, TestGroupingSearch, SolrCmdDistributorTest, TestFiltering, TestFunctionQuery, BasicFunctionalityTest, DirectUpdateHandlerTest, TestIndexSearcher, SoftAutoCommitTest, DistributedQueryElevationComponentTest, CurrencyFieldXmlFileTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest, SuggesterFSTTest, SolrRequestParserTest, TestFoldingMultitermQuery, DocValuesTest, SuggesterTSTTest, SuggesterTest, TestTrie, SuggesterWFSTTest, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, QueryEqualityTest, DirectUpdateHandlerOptimizeTest, StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest, SolrInfoMBeanTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest, TestQueryUtils, DirectSolrSpellCheckerTest, TestQueryTypes, PrimitiveFieldTypeTest, FileBasedSpellCheckerTest, TermsComponentTest, XmlUpdateRequestHandlerTest, RequestHandlersTest, DocumentBuilderTest, TestValueSourceCache, TermVectorComponentTest, TestIndexingPerformance, MoreLikeThisHandlerTest, SolrPluginUtilsTest, IndexSchemaTest, ReturnFieldsTest, UpdateRequestProcessorFactoryTest, TestCSVResponseWriter, MBeansHandlerTest, QueryParsingTest, TestAnalyzedSuggestions, TestPartialUpdateDeduplication, PingRequestHandlerTest, TestComponentsName, SearchHandlerTest, SOLR749Test, UpdateParamsTest, AlternateDirectoryTest, TestQuerySenderNoQuery, CopyFieldTest, BadComponentTest, TestMergePolicyConfig, TestSolrDeletionPolicy2, MultiTermTest, TestBinaryField, TestSearchPerf, MinimalSchemaTest, TestConfig, OutputWriterTest, TestPostingsSolrHighlighter, NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestPhraseSuggestions, TestCharFilters, TestXIncludeConfig, TestLMDirichletSimilarityFactory, TestLMJelinekMercerSimilarityFactory, TestIBSimilarityFactory, TestDefaultSimilarityFactory, OpenExchangeRatesOrgProviderTest, PluginInfoTest, TestFastLRUCache, ChaosMonkeyNothingIsSafeTest, PreAnalyzedFieldTest, TestSystemIdResolver, DateFieldTest, SpellingQueryConverterTest, RAMDirectoryFactoryTest, ClusterStateTest, TestSolrJ, TestDocumentBuilder, ZkNodePropsTest, SystemInfoHandlerTest, UUIDFieldTest, FileUtilsTest, CircularListTest, DistributedIntervalFacetingTest, SolrTestCaseJ4Test, TestHighlightDedupGrouping, TestTolerantSearch, ExpressionTest, AbstractAnalyticsFacetTest, FunctionTest, AsyncMigrateRouteKeyTest, CollectionsAPIAsyncDistributedZkTest, DeleteInactiveReplicaTest, DistribDocExpirationUpdateProcessorTest, MigrateRouteKeyTest, OverseerStatusTest, RemoteQueryErrorTest, ReplicationFactorTest, RollingRestartTest, SSLMigrationTest, ShardSplitTest, TestCollectionAPI, TestMiniSolrCloudCluster, TestModifyConfFiles, TestRequestStatusCollectionAPI, TestShortCircuitedRequests, TriLevelCompositeIdRoutingTest, HdfsBasicDistributedZk2Test, HdfsCollectionsAPIDistributedZkTest, HdfsUnloadDistributedZkTest, StressHdfsTest, QueryResultKeyTest, TestNonNRTOpen, TestShardHandlerFactory, TestSolrXml, TestSolrXmlPersistence, CoreAdminCreateDiscoverTest, CoreMergeIndexesAdminHandlerTest, InfoHandlerTest, DistributedDebugComponentTest, DistributedQueryComponentOptimizationTest, DistributedSuggestComponentTest, SuggestComponentTest, TestChildDocTransformer, TestManagedResource, TestDefaultSearchFieldResource, TestDynamicFieldResource, TestFieldResource, TestSchemaNameResource, TestSchemaResource, TestSchemaSimilarityResource, TestSerializedLuceneMatchVersion, TestUniqueKeyFieldResource, TestManagedStopFilterFactory, TestManagedSynonymFilterFactory, ChangedSchemaMergeTest, DateRangeFieldTest, EnumFieldTest, ModifyConfFileTest, TestCloudManagedSchema, TestCloudSchemaless] [junit4] Completed in 334.26s, 1 test, 1 error <<< FAILURES! [...truncated 78 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:467: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:447: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:45: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:37: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:189: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:496: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1298: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:922: There were test failures: 422 suites, 1756 tests, 1 error, 44 ignored (23 assumptions) Total time: 146 minutes 27 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 64bit/jdk1.8.0_20-ea-b23 -XX:+UseCompressedOops -XX:+UseSerialGC Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
