Hi, this test fails all the time on any operating system. Please fix or disable it!
Uwe ----- Uwe Schindler H.-H.-Meier-Allee 63, D-28213 Bremen http://www.thetaphi.de eMail: [email protected] > -----Original Message----- > From: Policeman Jenkins Server [mailto:[email protected]] > Sent: Saturday, August 23, 2014 11:11 PM > To: [email protected]; [email protected]; [email protected] > Subject: [JENKINS] Lucene-Solr-4.x-MacOSX (64bit/jdk1.8.0) - Build # 1750 - > Still Failing! > > Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-MacOSX/1750/ > Java: 64bit/jdk1.8.0 -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:56511/n/collection1 > > Stack Trace: > org.apache.solr.client.solrj.SolrServerException: Timeout occured while > waiting response from server at: https://127.0.0.1:56511/n/collection1 > at > __randomizedtesting.SeedInfo.seed([83AF82324C594018:2490C2A3B062024] > :0) > at > org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrSer > ver.java:560) > 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(Abstrac > tUpdateRequest.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(BaseDistri > butedSearchTestCase.java:871) > at sun.reflect.GeneratedMethodAccessor47.invoke(Unknown > Source) > at > sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAcces > sorImpl.java:43) > at java.lang.reflect.Method.invoke(Method.java:483) > at > com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomize > dRunner.java:1618) > at > com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Rando > mizedRunner.java:827) > at > com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Rando > mizedRunner.java:863) > at > com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Rando > mizedRunner.java:877) > at > com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1. > evaluate(SystemPropertiesRestoreRule.java:53) > at > org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRule > SetupTeardownChained.java:50) > at > org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCa > cheSanity.java:51) > at > org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeA > fterRule.java:46) > at > com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1 > .evaluate(SystemPropertiesInvariantRule.java:55) > at > org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleTh > readAndTestName.java:49) > at > org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRule > IgnoreAfterMaxFailures.java:65) > at > org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure > .java:48) > at > com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat > ementAdapter.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(ThreadL > eakControl.java:458) > at > com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran > domizedRunner.java:836) > at > com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(Rando > mizedRunner.java:738) > at > com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(Rando > mizedRunner.java:772) > at > com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Rando > mizedRunner.java:783) > at > com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat > ementAdapter.java:36) > at > com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1. > evaluate(SystemPropertiesRestoreRule.java:53) > at > org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeA > fterRule.java:46) > at > org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreCl > assName.java:42) > at > com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1 > .evaluate(SystemPropertiesInvariantRule.java:55) > at > com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet > hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) > at > com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMet > hodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) > at > com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat > ementAdapter.java:36) > at > com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat > ementAdapter.java:36) > at > com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat > ementAdapter.java:36) > at > org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAss > ertionsRequired.java:43) > at > org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure > .java:48) > at > org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRule > IgnoreAfterMaxFailures.java:65) > at > org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnore > TestSuites.java:55) > at > com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(Stat > ementAdapter.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(AbstractSessio > nInputBuffer.java:160) > at > org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java: > 84) > at > org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessio > nInputBuffer.java:273) > at > org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultH > ttpResponseParser.java:140) > at > org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultH > ttpResponseParser.java:57) > at > org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessagePars > er.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.receiveResponse > Header(ManagedClientConnectionImpl.java:197) > at > org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRe > questExecutor.java:271) > at > org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecut > or.java:123) > at > org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequ > estDirector.java:682) > at > org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequest > Director.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(HttpSolrSer > ver.java:448) > ... 47 more > > > > > Build Log: > [...truncated 11610 lines...] > [junit4] Suite: org.apache.solr.schema.TestCloudSchemaless > [junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/init-core-data-001 > [junit4] 2> 3331237 T8931 oas.SolrTestCaseJ4.buildSSLConfig Randomized > ssl (true) and clientAuth (false) > [junit4] 2> 3331238 T8931 > oas.BaseDistributedSearchTestCase.initHostContext Setting hostContext > system property: /n/ > [junit4] 2> 3331242 T8931 oas.SolrTestCaseJ4.setUp ###Starting > testDistribSearch > [junit4] 2> 3331242 T8931 oasc.ZkTestServer.run STARTING ZK TEST SERVER > [junit4] 1> client port:0.0.0.0/0.0.0.0:0 > [junit4] 2> 3331244 T8932 > oasc.ZkTestServer$ZKServerMain.runFromConfig Starting server > [junit4] 2> 3331345 T8931 oasc.ZkTestServer.run start zk server on > port:56481 > [junit4] 2> 3331347 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3331352 T8938 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@5c151058 > name:ZooKeeperConnection Watcher:127.0.0.1:56481 got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3331352 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3331353 T8931 oascc.SolrZkClient.makePath makePath: /solr > [junit4] 2> 3331365 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3331370 T8940 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@1b59867f > name:ZooKeeperConnection Watcher:127.0.0.1:56481/solr got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3331370 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3331370 T8931 oascc.SolrZkClient.makePath makePath: > /collections/collection1 > [junit4] 2> 3331378 T8931 oascc.SolrZkClient.makePath makePath: > /collections/collection1/shards > [junit4] 2> 3331384 T8931 oascc.SolrZkClient.makePath makePath: > /collections/control_collection > [junit4] 2> 3331390 T8931 oascc.SolrZkClient.makePath makePath: > /collections/control_collection/shards > [junit4] 2> 3331396 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/solrconfig-schemaless.xml to > /configs/conf1/solrconfig.xml > [junit4] 2> 3331398 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/solrconfig.xml > [junit4] 2> 3331410 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/schema-add-schema-fields-update-processor.xml > to /configs/conf1/schema.xml > [junit4] 2> 3331410 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/schema.xml > [junit4] 2> 3331417 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to > /configs/conf1/solrconfig.snippet.randomindexconfig.xml > [junit4] 2> 3331418 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/solrconfig.snippet.randomindexconfig.xml > [junit4] 2> 3331425 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt > [junit4] 2> 3331426 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/stopwords.txt > [junit4] 2> 3331434 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt > [junit4] 2> 3331434 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/protwords.txt > [junit4] 2> 3331441 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml > [junit4] 2> 3331442 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/currency.xml > [junit4] 2> 3331447 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/enumsConfig.xml to > /configs/conf1/enumsConfig.xml > [junit4] 2> 3331448 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/enumsConfig.xml > [junit4] 2> 3331454 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/open-exchange-rates.json to > /configs/conf1/open-exchange-rates.json > [junit4] 2> 3331455 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/open-exchange-rates.json > [junit4] 2> 3331461 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to > /configs/conf1/mapping-ISOLatin1Accent.txt > [junit4] 2> 3331462 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/mapping-ISOLatin1Accent.txt > [junit4] 2> 3331469 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/old_synonyms.txt to > /configs/conf1/old_synonyms.txt > [junit4] 2> 3331470 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/old_synonyms.txt > [junit4] 2> 3331478 T8931 oasc.AbstractZkTestCase.putConfig put > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/core/src/test- > files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt > [junit4] 2> 3331479 T8931 oascc.SolrZkClient.makePath makePath: > /configs/conf1/synonyms.txt > [junit4] 2> 3331489 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3331493 T8942 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@40d6d3f8 > name:ZooKeeperConnection Watcher:127.0.0.1:56481/solr got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3331493 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3333377 T8931 oejs.Server.doStart jetty-8.1.10.v20130312 > [junit4] 2> 3333384 T8931 oejus.SslContextFactory.doStart Enabled > Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, > TLSv1, TLSv1.1, TLSv1.2] > [junit4] 2> 3333386 T8931 oejs.AbstractConnector.doStart Started > [email protected]:56485 > [junit4] 2> 3333390 T8931 oass.SolrDispatchFilter.init > SolrDispatchFilter.init() > [junit4] 2> 3333391 T8931 oasc.SolrResourceLoader.locateSolrHome JNDI > not configured for solr (NoInitialContextEx) > [junit4] 2> 3333391 T8931 oasc.SolrResourceLoader.locateSolrHome using > system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002 > [junit4] 2> 3333392 T8931 oasc.SolrResourceLoader.<init> new > SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr- > 4.x-MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/' > [junit4] 2> 3333452 T8931 oasc.ConfigSolr.fromFile Loading container > configuration from /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/solr.xml > [junit4] 2> 3333492 T8931 oasc.CoreContainer.<init> New CoreContainer > 1236540236 > [junit4] 2> 3333492 T8931 oasc.CoreContainer.load Loading cores into > CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/] > [junit4] 2> 3333493 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting socketTimeout to: 90000 > [junit4] 2> 3333493 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting urlScheme to: > [junit4] 2> 3333493 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting connTimeout to: 15000 > [junit4] 2> 3333494 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maxConnectionsPerHost to: 20 > [junit4] 2> 3333494 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting corePoolSize to: 0 > [junit4] 2> 3333494 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maximumPoolSize to: 2147483647 > [junit4] 2> 3333495 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maxThreadIdleTime to: 5 > [junit4] 2> 3333495 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting sizeOfQueue to: -1 > [junit4] 2> 3333495 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting fairnessPolicy to: false > [junit4] 2> 3333498 T8931 oasu.UpdateShardHandler.<init> Creating > UpdateShardHandler HTTP client with params: > socketTimeout=340000&connTimeout=45000&retry=false > [junit4] 2> 3333501 T8931 oasl.LogWatcher.createWatcher SLF4J impl is > org.slf4j.impl.Log4jLoggerFactory > [junit4] 2> 3333501 T8931 oasl.LogWatcher.newRegisteredLogWatcher > Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] > [junit4] 2> 3333502 T8931 oasc.CoreContainer.load Host Name: 127.0.0.1 > [junit4] 2> 3333502 T8931 oasc.ZkContainer.initZooKeeper Zookeeper > client=127.0.0.1:56481/solr > [junit4] 2> 3333503 T8931 oasc.ZkController.checkChrootPath zkHost > includes chroot > [junit4] 2> 3333503 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3333506 T8953 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@39d0a4a3 > name:ZooKeeperConnection Watcher:127.0.0.1:56481 got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3333507 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3333511 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3333514 T8955 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@6bd65bcc > name:ZooKeeperConnection Watcher:127.0.0.1:56481/solr got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3333515 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3333517 T8931 oascc.SolrZkClient.makePath makePath: > /overseer/queue > [junit4] 2> 3333525 T8931 oascc.SolrZkClient.makePath makePath: > /overseer/collection-queue-work > [junit4] 2> 3333532 T8931 oascc.SolrZkClient.makePath makePath: > /overseer/collection-map-running > [junit4] 2> 3333540 T8931 oascc.SolrZkClient.makePath makePath: > /overseer/collection-map-completed > [junit4] 2> 3333547 T8931 oascc.SolrZkClient.makePath makePath: > /overseer/collection-map-failure > [junit4] 2> 3333557 T8931 oascc.SolrZkClient.makePath makePath: > /live_nodes > [junit4] 2> 3333561 T8931 oasc.ZkController.createEphemeralLiveNode > Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56485_n > [junit4] 2> 3333563 T8931 oascc.SolrZkClient.makePath makePath: > /live_nodes/127.0.0.1:56485_n > [junit4] 2> 3333572 T8931 oascc.SolrZkClient.makePath makePath: > /overseer_elect > [junit4] 2> 3333578 T8931 oascc.SolrZkClient.makePath makePath: > /overseer_elect/election > [junit4] 2> 3333584 T8931 oasc.Overseer.close Overseer (id=null) closing > [junit4] 2> 3333590 T8931 oasc.OverseerElectionContext.runLeaderProcess > I am going to be the leader 127.0.0.1:56485_n > [junit4] 2> 3333590 T8931 oascc.SolrZkClient.makePath makePath: > /overseer_elect/leader > [junit4] 2> 3333597 T8931 oasc.Overseer.start Overseer > (id=92328769183744004-127.0.0.1:56485_n-n_0000000000) starting > [junit4] 2> 3333605 T8931 oascc.SolrZkClient.makePath makePath: > /overseer/queue-work > [junit4] 2> 3333634 T8931 oasc.OverseerAutoReplicaFailoverThread.<init> > Starting OverseerAutoReplicaFailoverThread > autoReplicaFailoverWorkLoopDelay=10000 > autoReplicaFailoverWaitAfterExpiration=30000 > autoReplicaFailoverBadNodeExpiration=60000 > [junit4] 2> 3333636 T8956 oasc.Overseer$ClusterStateUpdater.run Starting > to work on the main queue > [junit4] 2> 3333638 T8957 oasc.OverseerCollectionProcessor.run Process > current queue of collection creations > [junit4] 2> 3333640 T8931 oascc.SolrZkClient.makePath makePath: > /clusterstate.json > [junit4] 2> 3333646 T8931 oascc.SolrZkClient.makePath makePath: > /aliases.json > [junit4] 2> 3333651 T8931 > oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating > cluster state from ZooKeeper... > [junit4] 2> 3333667 T8959 oasc.ZkController.publish publishing > core=collection1 state=down collection=control_collection > [junit4] 2> 3333668 T8959 oasc.ZkController.publish numShards not found > on descriptor - reading it from system property > [junit4] 2> 3333670 T8959 oasc.ZkController.waitForCoreNodeName look > for our core node name > [junit4] 2> 3333670 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3333677 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Update state > numShards=1 message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"https://127.0.0.1:56485/n";, > [junit4] 2> "node_name":"127.0.0.1:56485_n", > [junit4] 2> "numShards":"1", > [junit4] 2> "state":"down", > [junit4] 2> "shard":null, > [junit4] 2> "collection":"control_collection", > [junit4] 2> "operation":"state"} > [junit4] 2> 3333677 T8956 > oasc.Overseer$ClusterStateUpdater.createCollection Create collection > control_collection with shards [shard1] > [junit4] 2> 3333678 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to > shard shard=shard1 > [junit4] 2> 3333685 T8960 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> 3334671 T8959 oasc.ZkController.waitForShardId waiting to > find > shard id in clusterstate for collection1 > [junit4] 2> 3334671 T8959 oasc.ZkController.createCollectionZkNode Check > for collection zkNode:control_collection > [junit4] 2> 3334673 T8959 oasc.ZkController.createCollectionZkNode > Collection zkNode exists > [junit4] 2> 3334673 T8959 oascc.ZkStateReader.readConfigName Load > collection config from:/collections/control_collection > [junit4] 2> 3334675 T8959 oascc.ZkStateReader.readConfigName > path=/collections/control_collection configName=conf1 specified config > exists in ZooKeeper > [junit4] 2> 3334676 T8959 oasc.SolrResourceLoader.<init> new > SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr- > 4.x-MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/' > [junit4] 2> 3334677 T8959 oasc.SolrResourceLoader.replaceClassLoader > Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/lib/.svn/' to classloader > [junit4] 2> 3334678 T8959 oasc.SolrResourceLoader.replaceClassLoader > Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/lib/classes/' to classloader > [junit4] 2> 3334679 T8959 oasc.SolrResourceLoader.replaceClassLoader > Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/lib/README' to classloader > [junit4] 2> 3334725 T8959 oasc.SolrConfig.<init> Using Lucene > MatchVersion: 4.11.0 > [junit4] 2> 3334737 T8959 oasc.SolrConfig.<init> Loaded SolrConfig: > solrconfig.xml > [junit4] 2> 3334741 T8959 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> 3334744 T8959 oass.IndexSchema.readSchema Reading Solr > Schema from schema.xml > [junit4] 2> 3334748 T8959 oass.IndexSchema.readSchema [collection1] > Schema name=add-schema-fields-update-processor > [junit4] 2> 3334760 T8959 oass.IndexSchema.readSchema unique key field: > id > [junit4] 2> 3334764 T8959 > oass.ManagedIndexSchema.persistManagedSchemaToZooKeeper Created > and persisted managed schema znode at /configs/conf1/managed-schema > [junit4] 2> 3334768 T8959 oascc.SolrZkClient.makePath makePath: > /configs/conf1/schema.xml.bak > [junit4] 2> 3334779 T8959 > 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> 3334779 T8959 oasc.CoreContainer.create Creating SolrCore > 'collection1' using configuration from collection control_collection > [junit4] 2> 3334780 T8959 oasc.SolrCore.initDirectoryFactory > solr.NRTCachingDirectoryFactory > [junit4] 2> 3334780 T8959 oasc.SolrCore.<init> [collection1] Opening new > SolrCore at /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/, dataDir=/Users/jenkins/workspace/Lucene- > Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/data/ > [junit4] 2> 3334780 T8959 oasc.SolrCore.<init> JMX monitoring not > detected for core: collection1 > [junit4] 2> 3334782 T8959 oasc.CachingDirectoryFactory.get return new > directory for /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/data > [junit4] 2> 3334782 T8959 oasc.SolrCore.getNewIndexDir New index > directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr- > 4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/data/index/ > [junit4] 2> 3334783 T8959 oasc.SolrCore.initIndex WARN [collection1] Solr > index directory '/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/data/index' doesn't exist. Creating new index... > [junit4] 2> 3334783 T8959 oasc.CachingDirectoryFactory.get return new > directory for /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/data/index > [junit4] 2> 3334784 T8959 oasu.RandomMergePolicy.<init> > RandomMergePolicy wrapping class > org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: > minMergeSize=0, mergeFactor=10, maxMergeSize=1921828908, > maxMergeSizeForForcedMerge=9223372036854775807, > calibrateSizeByDeletes=true, maxMergeDocs=2147483647, > maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] > [junit4] 2> 3334791 T8959 oasc.SolrDeletionPolicy.onCommit > SolrDeletionPolicy.onCommit: commits: num=1 > [junit4] 2> > commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/ > workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/data/index > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@38e5d56d; > maxCacheMB=48.0 > maxMergeSizeMB=4.0),segFN=segments_1,generation=1} > [junit4] 2> 3334791 T8959 oasc.SolrDeletionPolicy.updateCommits newest > commit generation = 1 > [junit4] 2> 3334794 T8959 oasup.UpdateRequestProcessorChain.init > creating updateRequestProcessorChain "add-unknown-fields-to-the- > schema" > [junit4] 2> 3334795 T8959 oasc.SolrCore.loadUpdateProcessorChains no > updateRequestProcessorChain defined as default, creating implicit default > [junit4] 2> 3334796 T8959 oasc.RequestHandlers.initHandlersFromConfig > created /update: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3334796 T8959 oasc.RequestHandlers.initHandlersFromConfig > created /update/json: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3334796 T8959 oasc.RequestHandlers.initHandlersFromConfig > created /update/csv: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3334797 T8959 oasc.RequestHandlers.initHandlersFromConfig > created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3334797 T8959 oasc.RequestHandlers.initHandlersFromConfig > created standard: solr.StandardRequestHandler > [junit4] 2> 3334798 T8959 oasc.RequestHandlers.initHandlersFromConfig > created /get: solr.RealTimeGetHandler > [junit4] 2> 3334798 T8959 oasc.RequestHandlers.initHandlersFromConfig > created /admin/: org.apache.solr.handler.admin.AdminHandlers > [junit4] 2> 3334798 T8959 oasc.RequestHandlers.initHandlersFromConfig > WARN Multiple requestHandler registered to the same name: /update > ignoring: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3334799 T8959 oasc.RequestHandlers.initHandlersFromConfig > created /update: solr.UpdateRequestHandler > [junit4] 2> 3334799 T8959 oasc.RequestHandlers.initHandlersFromConfig > adding lazy requestHandler: solr.ReplicationHandler > [junit4] 2> 3334800 T8959 oasc.RequestHandlers.initHandlersFromConfig > created /replication: solr.ReplicationHandler > [junit4] 2> 3334808 T8959 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3334810 T8959 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3334812 T8959 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3334815 T8959 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3334816 T8959 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3334819 T8959 oasu.CommitTracker.<init> Hard AutoCommit: > disabled > [junit4] 2> 3334819 T8959 oasu.CommitTracker.<init> Soft AutoCommit: > disabled > [junit4] 2> 3334820 T8959 oasu.RandomMergePolicy.<init> > RandomMergePolicy wrapping class > org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: > minMergeSize=1000, mergeFactor=21, > maxMergeSize=9223372036854775807, > maxMergeSizeForForcedMerge=9223372036854775807, > calibrateSizeByDeletes=true, maxMergeDocs=2147483647, > maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] > [junit4] 2> 3334824 T8959 oasc.SolrDeletionPolicy.onInit > SolrDeletionPolicy.onInit: commits: num=1 > [junit4] 2> > commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/ > workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-002/collection1/data/index > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@38e5d56d; > maxCacheMB=48.0 > maxMergeSizeMB=4.0),segFN=segments_1,generation=1} > [junit4] 2> 3334824 T8959 oasc.SolrDeletionPolicy.updateCommits newest > commit generation = 1 > [junit4] 2> 3334825 T8959 oass.SolrIndexSearcher.<init> Opening > Searcher@61107688[collection1] main > [junit4] 2> 3334830 T8959 oascc.ZkStateReader.readConfigName Load > collection config from:/collections/control_collection > [junit4] 2> 3334832 T8959 oascc.ZkStateReader.readConfigName > path=/collections/control_collection configName=conf1 specified config > exists in ZooKeeper > [junit4] 2> 3334833 T8959 oasr.ManagedResourceStorage.newStorageIO > Setting up ZooKeeper-based storage for the RestManager with znodeBase: > /configs/conf1 > [junit4] 2> 3334835 T8959 > oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured > ZooKeeperStorageIO with znodeBase: /configs/conf1 > [junit4] 2> 3334835 T8959 oasr.RestManager.init Initializing RestManager > with initArgs: {} > [junit4] 2> 3334835 T8959 oasr.ManagedResourceStorage.load Reading > _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 3334837 T8959 > oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream No > data found for znode /configs/conf1/_rest_managed.json > [junit4] 2> 3334837 T8959 oasr.ManagedResourceStorage.load Loaded null > at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 3334839 T8959 oascc.SolrZkClient.makePath makePath: > /configs/conf1/_rest_managed.json > [junit4] 2> 3334844 T8959 > oasr.ManagedResourceStorage$ZooKeeperStorageIO$1.close Wrote 38 > bytes to new znode /configs/conf1/_rest_managed.json > [junit4] 2> 3334845 T8959 > oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to > path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 3334846 T8959 oasr.RestManager.init Initializing 0 registered > ManagedResources > [junit4] 2> 3334846 T8959 > oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper > watch for the managed schema at /configs/conf1/managed-schema ... > [junit4] 2> 3334849 T8959 oasc.CoreContainer.registerCore registering > core: collection1 > [junit4] 2> 3334849 T8961 oasc.SolrCore.registerSearcher [collection1] > Registered new searcher Searcher@61107688[collection1] > main{StandardDirectoryReader(segments_1:1:nrt)} > [junit4] 2> 3334851 T8964 oasc.ZkController.register Register replica - > core:collection1 address:https://127.0.0.1:56485/n > collection:control_collection shard:shard1 > [junit4] 2> 3334853 T8931 oass.SolrDispatchFilter.init > user.dir=/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr-core/test/J0 > [junit4] 2> 3334854 T8931 oass.SolrDispatchFilter.init > SolrDispatchFilter.init() done > [junit4] 2> 3334858 T8964 oascc.SolrZkClient.makePath makePath: > /collections/control_collection/leader_elect/shard1/election > [junit4] 2> 3334866 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3334869 T8966 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@7375d6a6 > name:ZooKeeperConnection Watcher:127.0.0.1:56481/solr got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3334870 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3334874 T8931 > oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating > cluster state from ZooKeeper... > [junit4] 2> 3334876 T8964 > oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader > process for shard shard1 > [junit4] 2> 3334881 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3334882 T8931 oasc.ChaosMonkey.monkeyLog monkey: init - > expire sessions:false cause connection loss:false > [junit4] 2> 3334884 T8964 > oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough > replicas found to continue. > [junit4] 2> 3334884 T8964 > oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader > - try and sync > [junit4] 2> ASYNC NEW_CORE C3092 name=collection1 > org.apache.solr.core.SolrCore@674cd641 > url=https://127.0.0.1:56485/n/collection1 node=127.0.0.1:56485_n > C3092_STATE=coll:control_collection core:collection1 > props:{core=collection1, base_url=https://127.0.0.1:56485/n, > node_name=127.0.0.1:56485_n, state=down} > [junit4] 2> 3334885 T8964 C3092 P56485 oasc.SyncStrategy.sync Sync > replicas to https://127.0.0.1:56485/n/collection1/ > [junit4] 2> 3334885 T8964 C3092 P56485 oasc.SyncStrategy.syncReplicas > Sync Success - now sync replicas to me > [junit4] 2> 3334885 T8964 C3092 P56485 oasc.SyncStrategy.syncToMe > https://127.0.0.1:56485/n/collection1/ has no replicas > [junit4] 2> 3334885 T8964 > oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: > https://127.0.0.1:56485/n/collection1/ shard1 > [junit4] 2> 3334886 T8964 oascc.SolrZkClient.makePath makePath: > /collections/control_collection/leaders/shard1 > [junit4] 2> 3334933 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3334937 T8960 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> 3334938 T8967 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> 3334959 T8964 oasc.ZkController.register We are > https://127.0.0.1:56485/n/collection1/ and leader is > https://127.0.0.1:56485/n/collection1/ > [junit4] 2> 3334959 T8964 oasc.ZkController.register No LogReplay needed > for core=collection1 baseURL=https://127.0.0.1:56485/n > [junit4] 2> 3334960 T8964 oasc.ZkController.checkRecovery I am the > leader, no recovery necessary > [junit4] 2> 3334960 T8964 oasc.ZkController.publish publishing > core=collection1 state=active collection=control_collection > [junit4] 2> 3334961 T8964 oasc.ZkController.publish numShards not found > on descriptor - reading it from system property > [junit4] 2> 3334966 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3334975 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Update state > numShards=4 message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "core_node_name":"core_node1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"https://127.0.0.1:56485/n";, > [junit4] 2> "node_name":"127.0.0.1:56485_n", > [junit4] 2> "numShards":"4", > [junit4] 2> "state":"active", > [junit4] 2> "shard":"shard1", > [junit4] 2> "collection":"control_collection", > [junit4] 2> "operation":"state"} > [junit4] 2> 3335083 T8967 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> 3335085 T8960 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> 3336807 T8931 oasc.AbstractFullDistribZkTestBase.createJettys > create jetty 1 > [junit4] 2> 3336808 T8931 oejs.Server.doStart jetty-8.1.10.v20130312 > [junit4] 2> 3336814 T8931 oejus.SslContextFactory.doStart Enabled > Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, > TLSv1, TLSv1.1, TLSv1.2] > [junit4] 2> 3336815 T8931 oejs.AbstractConnector.doStart Started > [email protected]:56489 > [junit4] 2> 3336818 T8931 oass.SolrDispatchFilter.init > SolrDispatchFilter.init() > [junit4] 2> 3336818 T8931 oasc.SolrResourceLoader.locateSolrHome JNDI > not configured for solr (NoInitialContextEx) > [junit4] 2> 3336818 T8931 oasc.SolrResourceLoader.locateSolrHome using > system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003 > [junit4] 2> 3336819 T8931 oasc.SolrResourceLoader.<init> new > SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr- > 4.x-MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/' > [junit4] 2> 3336859 T8931 oasc.ConfigSolr.fromFile Loading container > configuration from /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/solr.xml > [junit4] 2> 3336894 T8931 oasc.CoreContainer.<init> New CoreContainer > 228531779 > [junit4] 2> 3336895 T8931 oasc.CoreContainer.load Loading cores into > CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/] > [junit4] 2> 3336895 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting socketTimeout to: 90000 > [junit4] 2> 3336896 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting urlScheme to: > [junit4] 2> 3336897 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting connTimeout to: 15000 > [junit4] 2> 3336897 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maxConnectionsPerHost to: 20 > [junit4] 2> 3336897 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting corePoolSize to: 0 > [junit4] 2> 3336898 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maximumPoolSize to: 2147483647 > [junit4] 2> 3336898 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maxThreadIdleTime to: 5 > [junit4] 2> 3336898 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting sizeOfQueue to: -1 > [junit4] 2> 3336899 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting fairnessPolicy to: false > [junit4] 2> 3336902 T8931 oasu.UpdateShardHandler.<init> Creating > UpdateShardHandler HTTP client with params: > socketTimeout=340000&connTimeout=45000&retry=false > [junit4] 2> 3336904 T8931 oasl.LogWatcher.createWatcher SLF4J impl is > org.slf4j.impl.Log4jLoggerFactory > [junit4] 2> 3336905 T8931 oasl.LogWatcher.newRegisteredLogWatcher > Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] > [junit4] 2> 3336905 T8931 oasc.CoreContainer.load Host Name: 127.0.0.1 > [junit4] 2> 3336905 T8931 oasc.ZkContainer.initZooKeeper Zookeeper > client=127.0.0.1:56481/solr > [junit4] 2> 3336906 T8931 oasc.ZkController.checkChrootPath zkHost > includes chroot > [junit4] 2> 3336908 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3336911 T8978 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@7a322867 > name:ZooKeeperConnection Watcher:127.0.0.1:56481 got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3336912 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3336916 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3336918 T8980 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@10130cc7 > name:ZooKeeperConnection Watcher:127.0.0.1:56481/solr got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3336919 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3336936 T8931 > oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating > cluster state from ZooKeeper... > [junit4] 2> 3337945 T8931 oasc.ZkController.createEphemeralLiveNode > Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56489_n > [junit4] 2> 3337947 T8931 oascc.SolrZkClient.makePath makePath: > /live_nodes/127.0.0.1:56489_n > [junit4] 2> 3337957 T8931 oasc.Overseer.close Overseer (id=null) closing > [junit4] 2> 3337967 T8982 oasc.ZkController.publish publishing > core=collection1 state=down collection=collection1 > [junit4] 2> 3337967 T8982 oasc.ZkController.publish numShards not found > on descriptor - reading it from system property > [junit4] 2> 3337969 T8982 oasc.ZkController.waitForCoreNodeName look > for our core node name > [junit4] 2> 3337969 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3337975 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Update state > numShards=4 message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"https://127.0.0.1:56489/n";, > [junit4] 2> "node_name":"127.0.0.1:56489_n", > [junit4] 2> "numShards":"4", > [junit4] 2> "state":"down", > [junit4] 2> "shard":null, > [junit4] 2> "collection":"collection1", > [junit4] 2> "operation":"state"} > [junit4] 2> 3337975 T8956 > oasc.Overseer$ClusterStateUpdater.createCollection Create collection > collection1 with shards [shard1, shard2, shard3, shard4] > [junit4] 2> 3337976 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to > shard shard=shard2 > [junit4] 2> 3337984 T8981 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> 3337984 T8960 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> 3337984 T8967 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> 3338971 T8982 oasc.ZkController.waitForShardId waiting to > find > shard id in clusterstate for collection1 > [junit4] 2> 3338972 T8982 oasc.ZkController.createCollectionZkNode Check > for collection zkNode:collection1 > [junit4] 2> 3338973 T8982 oasc.ZkController.createCollectionZkNode > Collection zkNode exists > [junit4] 2> 3338973 T8982 oascc.ZkStateReader.readConfigName Load > collection config from:/collections/collection1 > [junit4] 2> 3338976 T8982 oascc.ZkStateReader.readConfigName > path=/collections/collection1 configName=conf1 specified config exists in > ZooKeeper > [junit4] 2> 3338976 T8982 oasc.SolrResourceLoader.<init> new > SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr- > 4.x-MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/' > [junit4] 2> 3338978 T8982 oasc.SolrResourceLoader.replaceClassLoader > Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/lib/.svn/' to classloader > [junit4] 2> 3338978 T8982 oasc.SolrResourceLoader.replaceClassLoader > Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/lib/classes/' to classloader > [junit4] 2> 3338980 T8982 oasc.SolrResourceLoader.replaceClassLoader > Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/lib/README' to classloader > [junit4] 2> 3339054 T8982 oasc.SolrConfig.<init> Using Lucene > MatchVersion: 4.11.0 > [junit4] 2> 3339065 T8982 oasc.SolrConfig.<init> Loaded SolrConfig: > solrconfig.xml > [junit4] 2> 3339068 T8982 oass.IndexSchema.readSchema Reading Solr > Schema from managed-schema > [junit4] 2> 3339072 T8982 oass.IndexSchema.readSchema [collection1] > Schema name=add-schema-fields-update-processor > [junit4] 2> 3339084 T8982 oass.IndexSchema.readSchema unique key field: > id > [junit4] 2> 3339084 T8982 oasc.CoreContainer.create Creating SolrCore > 'collection1' using configuration from collection collection1 > [junit4] 2> 3339084 T8982 oasc.SolrCore.initDirectoryFactory > solr.NRTCachingDirectoryFactory > [junit4] 2> 3339085 T8982 oasc.SolrCore.<init> [collection1] Opening new > SolrCore at /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/, dataDir=/Users/jenkins/workspace/Lucene- > Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/data/ > [junit4] 2> 3339085 T8982 oasc.SolrCore.<init> JMX monitoring not > detected for core: collection1 > [junit4] 2> 3339087 T8982 oasc.CachingDirectoryFactory.get return new > directory for /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/data > [junit4] 2> 3339089 T8982 oasc.SolrCore.getNewIndexDir New index > directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr- > 4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/data/index/ > [junit4] 2> 3339090 T8982 oasc.SolrCore.initIndex WARN [collection1] Solr > index directory '/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/data/index' doesn't exist. Creating new index... > [junit4] 2> 3339097 T8982 oasc.CachingDirectoryFactory.get return new > directory for /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/data/index > [junit4] 2> 3339100 T8982 oasu.RandomMergePolicy.<init> > RandomMergePolicy wrapping class > org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: > minMergeSize=0, mergeFactor=10, maxMergeSize=1921828908, > maxMergeSizeForForcedMerge=9223372036854775807, > calibrateSizeByDeletes=true, maxMergeDocs=2147483647, > maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] > [junit4] 2> 3339110 T8982 oasc.SolrDeletionPolicy.onCommit > SolrDeletionPolicy.onCommit: commits: num=1 > [junit4] 2> > commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/ > workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/data/index > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@78ac4d52; > maxCacheMB=48.0 > maxMergeSizeMB=4.0),segFN=segments_1,generation=1} > [junit4] 2> 3339111 T8982 oasc.SolrDeletionPolicy.updateCommits newest > commit generation = 1 > [junit4] 2> 3339114 T8982 oasup.UpdateRequestProcessorChain.init > creating updateRequestProcessorChain "add-unknown-fields-to-the- > schema" > [junit4] 2> 3339120 T8982 oasc.SolrCore.loadUpdateProcessorChains no > updateRequestProcessorChain defined as default, creating implicit default > [junit4] 2> 3339120 T8982 oasc.RequestHandlers.initHandlersFromConfig > created /update: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3339120 T8982 oasc.RequestHandlers.initHandlersFromConfig > created /update/json: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3339121 T8982 oasc.RequestHandlers.initHandlersFromConfig > created /update/csv: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3339121 T8982 oasc.RequestHandlers.initHandlersFromConfig > created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3339121 T8982 oasc.RequestHandlers.initHandlersFromConfig > created standard: solr.StandardRequestHandler > [junit4] 2> 3339122 T8982 oasc.RequestHandlers.initHandlersFromConfig > created /get: solr.RealTimeGetHandler > [junit4] 2> 3339122 T8982 oasc.RequestHandlers.initHandlersFromConfig > created /admin/: org.apache.solr.handler.admin.AdminHandlers > [junit4] 2> 3339122 T8982 oasc.RequestHandlers.initHandlersFromConfig > WARN Multiple requestHandler registered to the same name: /update > ignoring: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3339122 T8982 oasc.RequestHandlers.initHandlersFromConfig > created /update: solr.UpdateRequestHandler > [junit4] 2> 3339122 T8982 oasc.RequestHandlers.initHandlersFromConfig > adding lazy requestHandler: solr.ReplicationHandler > [junit4] 2> 3339122 T8982 oasc.RequestHandlers.initHandlersFromConfig > created /replication: solr.ReplicationHandler > [junit4] 2> 3339142 T8982 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3339145 T8982 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3339147 T8982 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3339148 T8982 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3339150 T8982 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3339153 T8982 oasu.CommitTracker.<init> Hard AutoCommit: > disabled > [junit4] 2> 3339153 T8982 oasu.CommitTracker.<init> Soft AutoCommit: > disabled > [junit4] 2> 3339155 T8982 oasu.RandomMergePolicy.<init> > RandomMergePolicy wrapping class > org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: > minMergeSize=1000, mergeFactor=21, > maxMergeSize=9223372036854775807, > maxMergeSizeForForcedMerge=9223372036854775807, > calibrateSizeByDeletes=true, maxMergeDocs=2147483647, > maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] > [junit4] 2> 3339157 T8982 oasc.SolrDeletionPolicy.onInit > SolrDeletionPolicy.onInit: commits: num=1 > [junit4] 2> > commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/ > workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-003/collection1/data/index > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@78ac4d52; > maxCacheMB=48.0 > maxMergeSizeMB=4.0),segFN=segments_1,generation=1} > [junit4] 2> 3339157 T8982 oasc.SolrDeletionPolicy.updateCommits newest > commit generation = 1 > [junit4] 2> 3339158 T8982 oass.SolrIndexSearcher.<init> Opening > Searcher@4f1c3ff4[collection1] main > [junit4] 2> 3339158 T8982 oascc.ZkStateReader.readConfigName Load > collection config from:/collections/collection1 > [junit4] 2> 3339162 T8982 oascc.ZkStateReader.readConfigName > path=/collections/collection1 configName=conf1 specified config exists in > ZooKeeper > [junit4] 2> 3339163 T8982 oasr.ManagedResourceStorage.newStorageIO > Setting up ZooKeeper-based storage for the RestManager with znodeBase: > /configs/conf1 > [junit4] 2> 3339165 T8982 > oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured > ZooKeeperStorageIO with znodeBase: /configs/conf1 > [junit4] 2> 3339165 T8982 oasr.RestManager.init Initializing RestManager > with initArgs: {} > [junit4] 2> 3339165 T8982 oasr.ManagedResourceStorage.load Reading > _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 3339169 T8982 > oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream > Read 38 bytes from znode /configs/conf1/_rest_managed.json > [junit4] 2> 3339169 T8982 oasr.ManagedResourceStorage.load Loaded > LinkedHashMap at path _rest_managed.json using > ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 3339169 T8982 oasr.ManagedResource.reloadFromStorage > Loaded initArgs {} for /rest/managed > [junit4] 2> 3339169 T8982 oasr.RestManager.init Initializing 0 registered > ManagedResources > [junit4] 2> 3339169 T8982 > oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper > watch for the managed schema at /configs/conf1/managed-schema ... > [junit4] 2> 3339175 T8982 oasc.CoreContainer.registerCore registering > core: collection1 > [junit4] 2> 3339175 T8983 oasc.SolrCore.registerSearcher [collection1] > Registered new searcher Searcher@4f1c3ff4[collection1] > main{StandardDirectoryReader(segments_1:1:nrt)} > [junit4] 2> 3339177 T8986 oasc.ZkController.register Register replica - > core:collection1 address:https://127.0.0.1:56489/n collection:collection1 > shard:shard2 > [junit4] 2> 3339178 T8931 oass.SolrDispatchFilter.init > user.dir=/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr-core/test/J0 > [junit4] 2> 3339178 T8931 oass.SolrDispatchFilter.init > SolrDispatchFilter.init() done > [junit4] 2> 3339191 T8986 oascc.SolrZkClient.makePath makePath: > /collections/collection1/leader_elect/shard2/election > [junit4] 2> 3339236 T8986 > oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader > process for shard shard2 > [junit4] 2> 3339240 T8986 > oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough > replicas found to continue. > [junit4] 2> 3339240 T8986 > oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader > - try and sync > [junit4] 2> ASYNC NEW_CORE C3093 name=collection1 > org.apache.solr.core.SolrCore@4406a681 > url=https://127.0.0.1:56489/n/collection1 node=127.0.0.1:56489_n > C3093_STATE=coll:collection1 core:collection1 props:{core=collection1, > base_url=https://127.0.0.1:56489/n, node_name=127.0.0.1:56489_n, > state=down} > [junit4] 2> 3339240 T8986 C3093 P56489 oasc.SyncStrategy.sync Sync > replicas to https://127.0.0.1:56489/n/collection1/ > [junit4] 2> 3339240 T8986 C3093 P56489 oasc.SyncStrategy.syncReplicas > Sync Success - now sync replicas to me > [junit4] 2> 3339241 T8986 C3093 P56489 oasc.SyncStrategy.syncToMe > https://127.0.0.1:56489/n/collection1/ has no replicas > [junit4] 2> 3339241 T8986 > oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: > https://127.0.0.1:56489/n/collection1/ shard2 > [junit4] 2> 3339241 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3339241 T8986 oascc.SolrZkClient.makePath makePath: > /collections/collection1/leaders/shard2 > [junit4] 2> 3339262 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3339376 T8967 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> 3339379 T8981 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> 3339381 T8960 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> 3339421 T8986 oasc.ZkController.register We are > https://127.0.0.1:56489/n/collection1/ and leader is > https://127.0.0.1:56489/n/collection1/ > [junit4] 2> 3339422 T8986 oasc.ZkController.register No LogReplay needed > for core=collection1 baseURL=https://127.0.0.1:56489/n > [junit4] 2> 3339423 T8986 oasc.ZkController.checkRecovery I am the > leader, no recovery necessary > [junit4] 2> 3339424 T8986 oasc.ZkController.publish publishing > core=collection1 state=active collection=collection1 > [junit4] 2> 3339424 T8986 oasc.ZkController.publish numShards not found > on descriptor - reading it from system property > [junit4] 2> 3339429 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3339437 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Update state > numShards=4 message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "core_node_name":"core_node1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"https://127.0.0.1:56489/n";, > [junit4] 2> "node_name":"127.0.0.1:56489_n", > [junit4] 2> "numShards":"4", > [junit4] 2> "state":"active", > [junit4] 2> "shard":"shard2", > [junit4] 2> "collection":"collection1", > [junit4] 2> "operation":"state"} > [junit4] 2> 3339549 T8960 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> 3339550 T8967 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> 3339551 T8981 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> 3341299 T8931 oasc.AbstractFullDistribZkTestBase.createJettys > create jetty 2 > [junit4] 2> 3341300 T8931 oejs.Server.doStart jetty-8.1.10.v20130312 > [junit4] 2> 3341307 T8931 oejus.SslContextFactory.doStart Enabled > Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, > TLSv1, TLSv1.1, TLSv1.2] > [junit4] 2> 3341308 T8931 oejs.AbstractConnector.doStart Started > [email protected]:56492 > [junit4] 2> 3341311 T8931 oass.SolrDispatchFilter.init > SolrDispatchFilter.init() > [junit4] 2> 3341312 T8931 oasc.SolrResourceLoader.locateSolrHome JNDI > not configured for solr (NoInitialContextEx) > [junit4] 2> 3341312 T8931 oasc.SolrResourceLoader.locateSolrHome using > system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004 > [junit4] 2> 3341312 T8931 oasc.SolrResourceLoader.<init> new > SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr- > 4.x-MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/' > [junit4] 2> 3341348 T8931 oasc.ConfigSolr.fromFile Loading container > configuration from /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/solr.xml > [junit4] 2> 3341379 T8931 oasc.CoreContainer.<init> New CoreContainer > 316144031 > [junit4] 2> 3341379 T8931 oasc.CoreContainer.load Loading cores into > CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/] > [junit4] 2> 3341380 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting socketTimeout to: 90000 > [junit4] 2> 3341380 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting urlScheme to: > [junit4] 2> 3341381 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting connTimeout to: 15000 > [junit4] 2> 3341381 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maxConnectionsPerHost to: 20 > [junit4] 2> 3341381 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting corePoolSize to: 0 > [junit4] 2> 3341382 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maximumPoolSize to: 2147483647 > [junit4] 2> 3341382 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maxThreadIdleTime to: 5 > [junit4] 2> 3341383 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting sizeOfQueue to: -1 > [junit4] 2> 3341383 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting fairnessPolicy to: false > [junit4] 2> 3341385 T8931 oasu.UpdateShardHandler.<init> Creating > UpdateShardHandler HTTP client with params: > socketTimeout=340000&connTimeout=45000&retry=false > [junit4] 2> 3341386 T8931 oasl.LogWatcher.createWatcher SLF4J impl is > org.slf4j.impl.Log4jLoggerFactory > [junit4] 2> 3341387 T8931 oasl.LogWatcher.newRegisteredLogWatcher > Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] > [junit4] 2> 3341387 T8931 oasc.CoreContainer.load Host Name: 127.0.0.1 > [junit4] 2> 3341388 T8931 oasc.ZkContainer.initZooKeeper Zookeeper > client=127.0.0.1:56481/solr > [junit4] 2> 3341388 T8931 oasc.ZkController.checkChrootPath zkHost > includes chroot > [junit4] 2> 3341390 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3341392 T8997 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@473e427a > name:ZooKeeperConnection Watcher:127.0.0.1:56481 got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3341397 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3341401 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3341404 T8999 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@2e49db92 > name:ZooKeeperConnection Watcher:127.0.0.1:56481/solr got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3341405 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3341428 T8931 > oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating > cluster state from ZooKeeper... > [junit4] 2> 3342437 T8931 oasc.ZkController.createEphemeralLiveNode > Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56492_n > [junit4] 2> 3342439 T8931 oascc.SolrZkClient.makePath makePath: > /live_nodes/127.0.0.1:56492_n > [junit4] 2> 3342453 T8931 oasc.Overseer.close Overseer (id=null) closing > [junit4] 2> 3342466 T9001 oasc.ZkController.publish publishing > core=collection1 state=down collection=collection1 > [junit4] 2> 3342466 T9001 oasc.ZkController.publish numShards not found > on descriptor - reading it from system property > [junit4] 2> 3342468 T9001 oasc.ZkController.waitForCoreNodeName look > for our core node name > [junit4] 2> 3342468 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3342473 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Update state > numShards=4 message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"https://127.0.0.1:56492/n";, > [junit4] 2> "node_name":"127.0.0.1:56492_n", > [junit4] 2> "numShards":"4", > [junit4] 2> "state":"down", > [junit4] 2> "shard":null, > [junit4] 2> "collection":"collection1", > [junit4] 2> "operation":"state"} > [junit4] 2> 3342473 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Collection already exists > with numShards=4 > [junit4] 2> 3342473 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to > shard shard=shard3 > [junit4] 2> 3342480 T9000 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> 3342480 T8967 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> 3342480 T8981 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> 3342480 T8960 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> 3343469 T9001 oasc.ZkController.waitForShardId waiting to > find > shard id in clusterstate for collection1 > [junit4] 2> 3343470 T9001 oasc.ZkController.createCollectionZkNode Check > for collection zkNode:collection1 > [junit4] 2> 3343471 T9001 oasc.ZkController.createCollectionZkNode > Collection zkNode exists > [junit4] 2> 3343471 T9001 oascc.ZkStateReader.readConfigName Load > collection config from:/collections/collection1 > [junit4] 2> 3343475 T9001 oascc.ZkStateReader.readConfigName > path=/collections/collection1 configName=conf1 specified config exists in > ZooKeeper > [junit4] 2> 3343475 T9001 oasc.SolrResourceLoader.<init> new > SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr- > 4.x-MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/' > [junit4] 2> 3343477 T9001 oasc.SolrResourceLoader.replaceClassLoader > Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/lib/.svn/' to classloader > [junit4] 2> 3343478 T9001 oasc.SolrResourceLoader.replaceClassLoader > Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/lib/classes/' to classloader > [junit4] 2> 3343478 T9001 oasc.SolrResourceLoader.replaceClassLoader > Adding 'file:/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/lib/README' to classloader > [junit4] 2> 3343530 T9001 oasc.SolrConfig.<init> Using Lucene > MatchVersion: 4.11.0 > [junit4] 2> 3343538 T9001 oasc.SolrConfig.<init> Loaded SolrConfig: > solrconfig.xml > [junit4] 2> 3343541 T9001 oass.IndexSchema.readSchema Reading Solr > Schema from managed-schema > [junit4] 2> 3343543 T9001 oass.IndexSchema.readSchema [collection1] > Schema name=add-schema-fields-update-processor > [junit4] 2> 3343552 T9001 oass.IndexSchema.readSchema unique key field: > id > [junit4] 2> 3343553 T9001 oasc.CoreContainer.create Creating SolrCore > 'collection1' using configuration from collection collection1 > [junit4] 2> 3343554 T9001 oasc.SolrCore.initDirectoryFactory > solr.NRTCachingDirectoryFactory > [junit4] 2> 3343554 T9001 oasc.SolrCore.<init> [collection1] Opening new > SolrCore at /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/, dataDir=/Users/jenkins/workspace/Lucene- > Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/data/ > [junit4] 2> 3343554 T9001 oasc.SolrCore.<init> JMX monitoring not > detected for core: collection1 > [junit4] 2> 3343555 T9001 oasc.CachingDirectoryFactory.get return new > directory for /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/data > [junit4] 2> 3343556 T9001 oasc.SolrCore.getNewIndexDir New index > directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr- > 4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/data/index/ > [junit4] 2> 3343556 T9001 oasc.SolrCore.initIndex WARN [collection1] Solr > index directory '/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/data/index' doesn't exist. Creating new index... > [junit4] 2> 3343557 T9001 oasc.CachingDirectoryFactory.get return new > directory for /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/data/index > [junit4] 2> 3343557 T9001 oasu.RandomMergePolicy.<init> > RandomMergePolicy wrapping class > org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: > minMergeSize=0, mergeFactor=10, maxMergeSize=1921828908, > maxMergeSizeForForcedMerge=9223372036854775807, > calibrateSizeByDeletes=true, maxMergeDocs=2147483647, > maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1] > [junit4] 2> 3343564 T9001 oasc.SolrDeletionPolicy.onCommit > SolrDeletionPolicy.onCommit: commits: num=1 > [junit4] 2> > commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/ > workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/data/index > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e83c351; > maxCacheMB=48.0 > maxMergeSizeMB=4.0),segFN=segments_1,generation=1} > [junit4] 2> 3343564 T9001 oasc.SolrDeletionPolicy.updateCommits newest > commit generation = 1 > [junit4] 2> 3343566 T9001 oasup.UpdateRequestProcessorChain.init > creating updateRequestProcessorChain "add-unknown-fields-to-the- > schema" > [junit4] 2> 3343567 T9001 oasc.SolrCore.loadUpdateProcessorChains no > updateRequestProcessorChain defined as default, creating implicit default > [junit4] 2> 3343568 T9001 oasc.RequestHandlers.initHandlersFromConfig > created /update: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3343568 T9001 oasc.RequestHandlers.initHandlersFromConfig > created /update/json: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3343568 T9001 oasc.RequestHandlers.initHandlersFromConfig > created /update/csv: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3343568 T9001 oasc.RequestHandlers.initHandlersFromConfig > created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3343568 T9001 oasc.RequestHandlers.initHandlersFromConfig > created standard: solr.StandardRequestHandler > [junit4] 2> 3343569 T9001 oasc.RequestHandlers.initHandlersFromConfig > created /get: solr.RealTimeGetHandler > [junit4] 2> 3343569 T9001 oasc.RequestHandlers.initHandlersFromConfig > created /admin/: org.apache.solr.handler.admin.AdminHandlers > [junit4] 2> 3343569 T9001 oasc.RequestHandlers.initHandlersFromConfig > WARN Multiple requestHandler registered to the same name: /update > ignoring: org.apache.solr.handler.UpdateRequestHandler > [junit4] 2> 3343569 T9001 oasc.RequestHandlers.initHandlersFromConfig > created /update: solr.UpdateRequestHandler > [junit4] 2> 3343570 T9001 oasc.RequestHandlers.initHandlersFromConfig > adding lazy requestHandler: solr.ReplicationHandler > [junit4] 2> 3343570 T9001 oasc.RequestHandlers.initHandlersFromConfig > created /replication: solr.ReplicationHandler > [junit4] 2> 3343580 T9001 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3343583 T9001 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3343584 T9001 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3343585 T9001 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3343586 T9001 oashl.XMLLoader.init > xsltCacheLifetimeSeconds=60 > [junit4] 2> 3343589 T9001 oasu.CommitTracker.<init> Hard AutoCommit: > disabled > [junit4] 2> 3343589 T9001 oasu.CommitTracker.<init> Soft AutoCommit: > disabled > [junit4] 2> 3343590 T9001 oasu.RandomMergePolicy.<init> > RandomMergePolicy wrapping class > org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: > minMergeSize=1000, mergeFactor=21, > maxMergeSize=9223372036854775807, > maxMergeSizeForForcedMerge=9223372036854775807, > calibrateSizeByDeletes=true, maxMergeDocs=2147483647, > maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] > [junit4] 2> 3343591 T9001 oasc.SolrDeletionPolicy.onInit > SolrDeletionPolicy.onInit: commits: num=1 > [junit4] 2> > commit{dir=NRTCachingDirectory(MMapDirectory@/Users/jenkins/ > workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-004/collection1/data/index > lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5e83c351; > maxCacheMB=48.0 > maxMergeSizeMB=4.0),segFN=segments_1,generation=1} > [junit4] 2> 3343592 T9001 oasc.SolrDeletionPolicy.updateCommits newest > commit generation = 1 > [junit4] 2> 3343592 T9001 oass.SolrIndexSearcher.<init> Opening > Searcher@747594c[collection1] main > [junit4] 2> 3343593 T9001 oascc.ZkStateReader.readConfigName Load > collection config from:/collections/collection1 > [junit4] 2> 3343595 T9001 oascc.ZkStateReader.readConfigName > path=/collections/collection1 configName=conf1 specified config exists in > ZooKeeper > [junit4] 2> 3343595 T9001 oasr.ManagedResourceStorage.newStorageIO > Setting up ZooKeeper-based storage for the RestManager with znodeBase: > /configs/conf1 > [junit4] 2> 3343596 T9001 > oasr.ManagedResourceStorage$ZooKeeperStorageIO.configure Configured > ZooKeeperStorageIO with znodeBase: /configs/conf1 > [junit4] 2> 3343596 T9001 oasr.RestManager.init Initializing RestManager > with initArgs: {} > [junit4] 2> 3343597 T9001 oasr.ManagedResourceStorage.load Reading > _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 3343601 T9001 > oasr.ManagedResourceStorage$ZooKeeperStorageIO.openInputStream > Read 38 bytes from znode /configs/conf1/_rest_managed.json > [junit4] 2> 3343601 T9001 oasr.ManagedResourceStorage.load Loaded > LinkedHashMap at path _rest_managed.json using > ZooKeeperStorageIO:path=/configs/conf1 > [junit4] 2> 3343602 T9001 oasr.ManagedResource.reloadFromStorage > Loaded initArgs {} for /rest/managed > [junit4] 2> 3343602 T9001 oasr.RestManager.init Initializing 0 registered > ManagedResources > [junit4] 2> 3343602 T9001 > oass.ZkIndexSchemaReader.createSchemaWatcher Creating ZooKeeper > watch for the managed schema at /configs/conf1/managed-schema ... > [junit4] 2> 3343604 T9001 oasc.CoreContainer.registerCore registering > core: collection1 > [junit4] 2> 3343605 T9002 oasc.SolrCore.registerSearcher [collection1] > Registered new searcher Searcher@747594c[collection1] > main{StandardDirectoryReader(segments_1:1:nrt)} > [junit4] 2> 3343607 T9005 oasc.ZkController.register Register replica - > core:collection1 address:https://127.0.0.1:56492/n collection:collection1 > shard:shard3 > [junit4] 2> 3343609 T8931 oass.SolrDispatchFilter.init > user.dir=/Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr-core/test/J0 > [junit4] 2> 3343609 T8931 oass.SolrDispatchFilter.init > SolrDispatchFilter.init() done > [junit4] 2> 3343627 T9005 oascc.SolrZkClient.makePath makePath: > /collections/collection1/leader_elect/shard3/election > [junit4] 2> 3343656 T9005 > oasc.ShardLeaderElectionContext.runLeaderProcess Running the leader > process for shard shard3 > [junit4] 2> 3343664 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3343670 T9005 > oasc.ShardLeaderElectionContext.waitForReplicasToComeUp Enough > replicas found to continue. > [junit4] 2> 3343670 T9005 > oasc.ShardLeaderElectionContext.runLeaderProcess I may be the new leader > - try and sync > [junit4] 2> ASYNC NEW_CORE C3094 name=collection1 > org.apache.solr.core.SolrCore@5154fd36 > url=https://127.0.0.1:56492/n/collection1 node=127.0.0.1:56492_n > C3094_STATE=coll:collection1 core:collection1 props:{core=collection1, > base_url=https://127.0.0.1:56492/n, node_name=127.0.0.1:56492_n, > state=down} > [junit4] 2> 3343671 T9005 C3094 P56492 oasc.SyncStrategy.sync Sync > replicas to https://127.0.0.1:56492/n/collection1/ > [junit4] 2> 3343672 T9005 C3094 P56492 oasc.SyncStrategy.syncReplicas > Sync Success - now sync replicas to me > [junit4] 2> 3343672 T9005 C3094 P56492 oasc.SyncStrategy.syncToMe > https://127.0.0.1:56492/n/collection1/ has no replicas > [junit4] 2> 3343672 T9005 > oasc.ShardLeaderElectionContext.runLeaderProcess I am the new leader: > https://127.0.0.1:56492/n/collection1/ shard3 > [junit4] 2> 3343672 T9005 oascc.SolrZkClient.makePath makePath: > /collections/collection1/leaders/shard3 > [junit4] 2> 3343699 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3343813 T8967 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> 3343813 T8981 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> 3343813 T8960 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> 3343813 T9000 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> 3343861 T9005 oasc.ZkController.register We are > https://127.0.0.1:56492/n/collection1/ and leader is > https://127.0.0.1:56492/n/collection1/ > [junit4] 2> 3343862 T9005 oasc.ZkController.register No LogReplay needed > for core=collection1 baseURL=https://127.0.0.1:56492/n > [junit4] 2> 3343864 T9005 oasc.ZkController.checkRecovery I am the > leader, no recovery necessary > [junit4] 2> 3343864 T9005 oasc.ZkController.publish publishing > core=collection1 state=active collection=collection1 > [junit4] 2> 3343864 T9005 oasc.ZkController.publish numShards not found > on descriptor - reading it from system property > [junit4] 2> 3343871 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3343879 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Update state > numShards=4 message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "core_node_name":"core_node2", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"https://127.0.0.1:56492/n";, > [junit4] 2> "node_name":"127.0.0.1:56492_n", > [junit4] 2> "numShards":"4", > [junit4] 2> "state":"active", > [junit4] 2> "shard":"shard3", > [junit4] 2> "collection":"collection1", > [junit4] 2> "operation":"state"} > [junit4] 2> 3344000 T8960 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> 3344003 T8981 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> 3344001 T9000 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> 3344003 T8967 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> 3345571 T8931 oasc.AbstractFullDistribZkTestBase.createJettys > create jetty 3 > [junit4] 2> 3345571 T8931 oejs.Server.doStart jetty-8.1.10.v20130312 > [junit4] 2> 3345578 T8931 oejus.SslContextFactory.doStart Enabled > Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, > TLSv1, TLSv1.1, TLSv1.2] > [junit4] 2> 3345580 T8931 oejs.AbstractConnector.doStart Started > [email protected]:56495 > [junit4] 2> 3345584 T8931 oass.SolrDispatchFilter.init > SolrDispatchFilter.init() > [junit4] 2> 3345585 T8931 oasc.SolrResourceLoader.locateSolrHome JNDI > not configured for solr (NoInitialContextEx) > [junit4] 2> 3345585 T8931 oasc.SolrResourceLoader.locateSolrHome using > system property solr.solr.home: > ../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-005 > [junit4] 2> 3345586 T8931 oasc.SolrResourceLoader.<init> new > SolrResourceLoader for directory: > '../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-005/' > [junit4] 2> 3345640 T8931 oasc.ConfigSolr.fromFile Loading container > configuration from /Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-005/solr.xml > [junit4] 2> 3345655 T8931 oasc.CoreContainer.<init> New CoreContainer > 1707688044 > [junit4] 2> 3345655 T8931 oasc.CoreContainer.load Loading cores into > CoreContainer > [instanceDir=../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-4.x- > MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001/tempDir-005/] > [junit4] 2> 3345656 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting socketTimeout to: 90000 > [junit4] 2> 3345657 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting urlScheme to: > [junit4] 2> 3345657 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting connTimeout to: 15000 > [junit4] 2> 3345657 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maxConnectionsPerHost to: 20 > [junit4] 2> 3345658 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting corePoolSize to: 0 > [junit4] 2> 3345658 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maximumPoolSize to: 2147483647 > [junit4] 2> 3345658 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting maxThreadIdleTime to: 5 > [junit4] 2> 3345658 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting sizeOfQueue to: -1 > [junit4] 2> 3345658 T8931 oashc.HttpShardHandlerFactory.getParameter > Setting fairnessPolicy to: false > [junit4] 2> 3345661 T8931 oasu.UpdateShardHandler.<init> Creating > UpdateShardHandler HTTP client with params: > socketTimeout=340000&connTimeout=45000&retry=false > [junit4] 2> 3345664 T8931 oasl.LogWatcher.createWatcher SLF4J impl is > org.slf4j.impl.Log4jLoggerFactory > [junit4] 2> 3345665 T8931 oasl.LogWatcher.newRegisteredLogWatcher > Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] > [junit4] 2> 3345666 T8931 oasc.CoreContainer.load Host Name: 127.0.0.1 > [junit4] 2> 3345666 T8931 oasc.ZkContainer.initZooKeeper Zookeeper > client=127.0.0.1:56481/solr > [junit4] 2> 3345666 T8931 oasc.ZkController.checkChrootPath zkHost > includes chroot > [junit4] 2> 3345668 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3345672 T9016 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@15ed8be2 > name:ZooKeeperConnection Watcher:127.0.0.1:56481 got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3345673 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3345683 T8931 oascc.ConnectionManager.waitForConnected > Waiting for client to connect to ZooKeeper > [junit4] 2> 3345686 T9018 oascc.ConnectionManager.process Watcher > org.apache.solr.common.cloud.ConnectionManager@e3072ae > name:ZooKeeperConnection Watcher:127.0.0.1:56481/solr got event > WatchedEvent state:SyncConnected type:None path:null path:null > type:None > [junit4] 2> 3345687 T8931 oascc.ConnectionManager.waitForConnected > Client is connected to ZooKeeper > [junit4] 2> 3345707 T8931 > oascc.ZkStateReader.createClusterStateWatchersAndUpdate Updating > cluster state from ZooKeeper... > [junit4] 2> 3346733 T8931 oasc.ZkController.createEphemeralLiveNode > Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56495_n > [junit4] 2> 3346736 T8931 oascc.SolrZkClient.makePath makePath: > /live_nodes/127.0.0.1:56495_n > [junit4] 2> 3346747 T8931 oasc.Overseer.close Overseer (id=null) closing > [junit4] 2> 3346762 T9020 oasc.ZkController.publish publishing > core=collection1 state=down collection=collection1 > [junit4] 2> 3346763 T9020 oasc.ZkController.publish numShards not found > on descriptor - reading it from system property > [junit4] 2> 3346764 T8960 > oasc.DistributedQueue$LatchChildWatcher.process LatchChildWatcher fired > on path: /overseer/queue state: SyncConnected type NodeChildrenChanged > [junit4] 2> 3346764 T9020 oasc.ZkController.waitForCoreNodeName look > for our core node name > [junit4] 2> 3346768 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Update state > numShards=4 message={ > [junit4] 2> "core":"collection1", > [junit4] 2> "roles":null, > [junit4] 2> "base_url":"https://127.0.0.1:56495/n";, > [junit4] 2> "node_name":"127.0.0.1:56495_n", > [junit4] 2> "numShards":"4", > [junit4] 2> "state":"down", > [junit4] 2> "shard":null, > [junit4] 2> "collection":"collection1", > [junit4] 2> "operation":"state"} > [junit4] 2> 3346768 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Collection already exists > with numShards=4 > [junit4] 2> 3346768 T8956 > oasc.Overseer$ClusterStateUpdater.updateState Assigning new node to > shard shard=shard4 > [junit4] 2> 3346777 T9000 oascc.ZkStateReader$2.process A cluster state > change: WatchedEvent state:SyncConnected type:NodeDataChanged > path:/clusterstate.json, has occurred - updating... (live nodes size: 4) > [junit4] 2> 3346778 T8967 oascc.ZkStateReader$2.process A cluster state > change: WatchedEvent state:SyncConnected type:NodeDataChanged > path:/clusterstate.json, has occurred - updating... (live nodes size: 4) > [junit4] 2> 3346777 T8981 oascc.ZkStateReader$2.process A cluster state > change: WatchedEvent state:SyncConnected type:NodeDataChanged > path:/clusterstate.json, has occurred - updating... (live nodes size: 4) > [junit4] 2> 3346777 T9019 oascc.ZkStateReader$2.process A cluster state > change: WatchedEvent state:SyncConnected type:NodeDataChanged > path:/clusterstate.json, has occurred - updating... (live nodes size: 4) > [junit4] 2> 3346777 T8960 oascc.ZkStateReader$2.process A cluster state > change: WatchedEvent state:SyncConnected type:NodeDataChanged > path:/clusterstate.json, has occurred - updating... (live nodes size: 4) > [junit4] 2> 3347768 T9020 oasc.ZkController.waitForShardId waiting to > find > shard id in clusterstate for collection1 > [junit4] 2> 3347768 T9020 oasc.ZkController.createCollectionZkNode Check > for collection zkNode:collection1 > [junit4] 2> 3347771 T9020 oasc.ZkController.createCollectionZkNode > Collection zkNode exists > [junit4] 2> 3347772 T9020 oascc.ZkStateReader.readConfigName Load > collection config from:/collections/collection1 > [junit4] 2> 3347774 T9020 oascc.ZkStat > > [...truncated too long message...] > > :54) > [junit4] > at > org.apache.solr.schema.TestCloudSchemaless.doTest(TestCloudSchemaless. > java:140) > [junit4] > at > org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistri > butedSearchTestCase.java:871) > [junit4] > at java.lang.Thread.run(Thread.java:745) > [junit4] > Caused by: java.net.SocketTimeoutException: Read timed out > [junit4] > at java.net.SocketInputStream.socketRead0(Native Method) > [junit4] > at > java.net.SocketInputStream.read(SocketInputStream.java:150) > [junit4] > at > java.net.SocketInputStream.read(SocketInputStream.java:121) > [junit4] > at > sun.security.ssl.InputRecord.readFully(InputRecord.java:465) > [junit4] > at > sun.security.ssl.InputRecord.read(InputRecord.java:503) > [junit4] > at > sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:954) > [junit4] > at > sun.security.ssl.SSLSocketImpl.readDataRecord(SSLSocketImpl.java:911) > [junit4] > at > sun.security.ssl.AppInputStream.read(AppInputStream.java:105) > [junit4] > at > org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessio > nInputBuffer.java:160) > [junit4] > at > org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java: > 84) > [junit4] > at > org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessio > nInputBuffer.java:273) > [junit4] > at > org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultH > ttpResponseParser.java:140) > [junit4] > at > org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultH > ttpResponseParser.java:57) > [junit4] > at > org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessagePars > er.java:260) > [junit4] > at > org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader > (AbstractHttpClientConnection.java:283) > [junit4] > at > org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader > (DefaultClientConnection.java:251) > [junit4] > at > org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponse > Header(ManagedClientConnectionImpl.java:197) > [junit4] > at > org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRe > questExecutor.java:271) > [junit4] > at > org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecut > or.java:123) > [junit4] > at > org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequ > estDirector.java:682) > [junit4] > at > org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequest > Director.java:486) > [junit4] > at > org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient > .java:863) > [junit4] > at > org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient > .java:82) > [junit4] > at > org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient > .java:106) > [junit4] > at > org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient > .java:57) > [junit4] > at > org.apache.solr.client.solrj.impl.HttpSolrServer.executeMethod(HttpSolrSer > ver.java:448) > [junit4] > ... 47 more > [junit4] 2> 3489057 T8931 oas.SolrTestCaseJ4.deleteCore ###deleteCore > [junit4] 2> NOTE: leaving temporary files on disk at: > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/solr- > core/test/J0/./temp/solr.schema.TestCloudSchemaless-83AF82324C594018- > 001 > [junit4] 2> NOTE: test params are: codec=Lucene410: {}, docValues:{}, > sim=RandomSimilarityProvider(queryNorm=false,coord=yes): {}, locale=fi, > timezone=America/Campo_Grande > [junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.8.0_20 (64- > bit)/cpus=2,threads=1,free=123398176,total=319094784 > [junit4] 2> NOTE: All tests run in this JVM: [AtomicUpdatesTest, > EchoParamsTest, BlockCacheTest, TestSort, > AddSchemaFieldsUpdateProcessorFactoryTest, DocumentBuilderTest, > AlternateDirectoryTest, ZkControllerTest, > DistributedExpandComponentTest, SolrXmlInZkTest, TestFastLRUCache, > TestRealTimeGet, SampleTest, TestHighlightDedupGrouping, > TestCollationFieldDocValues, AnalysisErrorHandlingTest, > TestFoldingMultitermQuery, SolrInfoMBeanTest, > CurrencyFieldOpenExchangeTest, TestNRTOpen, LeaderElectionTest, > TestReversedWildcardFilterFactory, DistributedIntervalFacetingTest, > CollectionsAPIDistributedZkTest, TestExpandComponent, ZkNodePropsTest, > DirectSolrConnectionTest, HdfsLockFactoryTest, > DistributedFacetPivotSmallTest, SuggesterTSTTest, BJQParserTest, > TestDefaultSimilarityFactory, SpellCheckComponentTest, SyncSliceTest, > TestCSVLoader, TestMissingGroups, TestOmitPositions, > DebugComponentTest, TestPivotHelperCode, TestCoreContainer, > HdfsDirectoryTest, ZkCLITest, TestSuggestSpellingConverter, TestQueryUtils, > MinimalSchemaTest, IndexSchemaTest, MergeStrategyTest, > TriLevelCompositeIdRoutingTest, TestPHPSerializedResponseWriter, > CoreContainerCoreInitFailuresTest, > DistributedQueryElevationComponentTest, TestRandomDVFaceting, > PluginInfoTest, TestLuceneMatchVersion, PrimitiveFieldTypeTest, > TestSearcherReuse, OverseerRolesTest, CoreAdminRequestStatusTest, > AnalyticsMergeStrategyTest, TestNoOpRegenerator, SOLR749Test, > TestSolr4Spatial2, ChaosMonkeySafeLeaderTest, > XsltUpdateRequestHandlerTest, TestAnalyzedSuggestions, > TestStressUserVersions, TestTolerantSearch, BasicZkTest, TestReload, > TestCursorMarkWithoutUniqueKey, HdfsUnloadDistributedZkTest, > SchemaVersionSpecificBehaviorTest, TestSolrQueryParser, > DistributedSpellCheckComponentTest, TestHighFrequencyDictionaryFactory, > PrimUtilsTest, TestHashPartitioner, TestRemoteStreaming, > SynonymTokenizerTest, BasicDistributedZkTest, > TestFieldTypeCollectionResource, > StatelessScriptUpdateProcessorFactoryTest, > DefaultValueUpdateProcessorTest, TestSolrQueryParserResource, > TestIntervalFaceting, TestRecoveryHdfs, TestCloudManagedSchema, > TestStressLucene, TestChildDocTransformer, ZkSolrClientTest, > TestConfigSets, CoreAdminHandlerTest, > TestOverriddenPrefixQueryForCustomFieldType, SuggesterFSTTest, > TestDocumentBuilder, SolrPluginUtilsTest, TestCharFilters, > TestFieldTypeResource, FieldMutatingUpdateProcessorTest, > TestDistributedGrouping, TestManagedResource, > SpellPossibilityIteratorTest, SharedFSAutoReplicaFailoverUtilsTest, > TestExtendedDismaxParser, MigrateRouteKeyTest, TestIBSimilarityFactory, > TestRandomFaceting, TestCoreDiscovery, TestInitQParser, > UpdateRequestProcessorFactoryTest, TestFastWriter, > TestManagedStopFilterFactory, TestComponentsName, > TestRequestStatusCollectionAPI, TestManagedSynonymFilterFactory, > BasicFunctionalityTest, OverseerTest, HardAutoCommitTest, > ShardRoutingCustomTest, TestDFRSimilarityFactory, RequestHandlersTest, > TestDistribDocBasedVersion, PreAnalyzedFieldTest, > DistributedQueryComponentOptimizationTest, > TermVectorComponentDistributedTest, SuggesterTest, CursorPagingTest, > HdfsBasicDistributedZkTest, SolrCoreCheckLockOnStartupTest, > HttpPartitionTest, TestSolrJ, ClusterStateTest, TestQuerySenderNoQuery, > TestRandomMergePolicy, HdfsWriteToMultipleCollectionsTest, > TestSolrQueryParserDefaultOperatorResource, TestSimpleQParserPlugin, > TestNonNRTOpen, BadIndexSchemaTest, TestSweetSpotSimilarityFactory, > ReturnFieldsTest, TestSchemaResource, TestSchemaVersionResource, > HighlighterTest, DistribCursorPagingTest, TestExceedMaxTermLength, > ResponseHeaderTest, TestLMDirichletSimilarityFactory, OverseerStatusTest, > FullSolrCloudDistribCmdsTest, HdfsRecoveryZkTest, > TestCollationKeyRangeQueries, TestDistributedSearch, TestSolrXmlPersistor, > SortByFunctionTest, FastVectorHighlighterTest, ClusterStateUpdateTest, > TestJmxIntegration, TestCloudPivotFacet, NotRequiredUniqueKeyTest, > DateMathParserTest, TestFiltering, AsyncMigrateRouteKeyTest, > TestDocBasedVersionConstraints, TestDynamicFieldResource, > TestJmxMonitoredMap, SpellingQueryConverterTest, DocValuesTest, > EnumFieldTest, TestArbitraryIndexDir, TestMaxScoreQueryParser, > PreAnalyzedUpdateProcessorTest, TestMultiCoreConfBootstrap, > FileBasedSpellCheckerTest, TestCloudInspectUtil, > ShowFileRequestHandlerTest, QueryParsingTest, DeleteReplicaTest, > ExternalFileFieldSortTest, TestAnalyzeInfixSuggestions, > BinaryUpdateRequestHandlerTest, MBeansHandlerTest, TestJoin, > DeleteLastCustomShardedReplicaTest, BlockDirectoryTest, > ResourceLoaderTest, SolrIndexSplitterTest, TestSolrCoreProperties, > TestComplexPhraseQParserPlugin, SuggestComponentTest, > DistributedSuggestComponentTest, TestClassNameShortening, > TestSchemaSimilarityResource, DirectSolrSpellCheckerTest, > CustomCollectionTest, DocumentAnalysisRequestHandlerTest, > TestCopyFieldCollectionResource, SearchHandlerTest, MultiTermTest, > AliasIntegrationTest, TestCloudSchemaless] > [junit4] Completed in 157.87s, 1 test, 1 error <<< FAILURES! > > [...truncated 667 lines...] > BUILD FAILED > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/build.xml:485: The > following error occurred while executing this line: > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/build.xml:465: The > following error occurred while executing this line: > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/build.xml:48: The > following error occurred while executing this line: > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/extra-targets.xml:37: > The following error occurred while executing this line: > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build.xml:189: The > following error occurred while executing this line: > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/common- > build.xml:494: The following error occurred while executing this line: > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/lucene/common- > build.xml:1343: The following error occurred while executing this line: > /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/lucene/common- > build.xml:958: There were test failures: 419 suites, 1733 tests, 1 error, 44 > ignored (17 assumptions) > > Total time: 153 minutes 52 seconds > Build step 'Invoke Ant' marked build as failure > [description-setter] Description set: Java: 64bit/jdk1.8.0 - > 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]
