Unable to start SQ

Anand_Krishnamoorthy · April 6, 2021, 12:43pm

Hi - I have spinned up a VM in AWS running Ubuntu and followed each and every step of the SQ installation, but still couldn’t fire up sonar in the browser. I’ve proxy passed via Nginx and when I hit the domain, I get to see only nginx default page and not sonar. Nor the domainname:9000 shows - the page isn’t available. Below are sonar logs:

es.log

root@ip-172-31-28-241:/opt/sonarqube/sonarqube/logs# tail -f es.log
2021.04.06 11:47:57 INFO es[o.e.n.Node] starting …
2021.04.06 11:47:57 INFO es[o.e.t.TransportService] publish_address {127.0.0.1:39151}, bound_addresses {127.0.0.1:39151}
2021.04.06 11:47:57 INFO es[o.e.b.BootstrapChecks] explicitly enforcing bootstrap checks
2021.04.06 11:47:57 INFO es[o.e.c.c.Coordinator] setting initial configuration to VotingConfiguration{6o2pPBsDQn2mXRVKgYI7xQ}
2021.04.06 11:47:57 INFO es[o.e.c.s.MasterService] elected-as-master ([1] nodes joined)[{sonarqube}{6o2pPBsDQn2mXRVKgYI7xQ}{8AQV_WbYSeirkkhTwbw-bg}{127.0.0.1}{127.0.0.1:39151}{dimr}{rack_id=sonarqube} elect leader, BECOME_MASTER_TASK, FINISH_ELECTION], term: 1, version: 1, delta: master node changed {previous , current [{sonarqube}{6o2pPBsDQn2mXRVKgYI7xQ}{8AQV_WbYSeirkkhTwbw-bg}{127.0.0.1}{127.0.0.1:39151}{dimr}{rack_id=sonarqube}]}
2021.04.06 11:47:57 INFO es[o.e.c.c.CoordinationState] cluster UUID set to [w1ldxTFWTSKGBCo1A1qjtQ]
2021.04.06 11:47:57 INFO es[o.e.c.s.ClusterApplierService] master node changed {previous , current [{sonarqube}{6o2pPBsDQn2mXRVKgYI7xQ}{8AQV_WbYSeirkkhTwbw-bg}{127.0.0.1}{127.0.0.1:39151}{dimr}{rack_id=sonarqube}]}, term: 1, version: 1, reason: Publication{term=1, version=1}
2021.04.06 11:47:57 INFO es[o.e.h.AbstractHttpServerTransport] publish_address {127.0.0.1:9001}, bound_addresses {127.0.0.1:9001}
2021.04.06 11:47:57 INFO es[o.e.n.Node] started
2021.04.06 11:47:58 INFO es[o.e.g.GatewayService] recovered [0] indices into cluster_state

Blockquote

sonar-20210406.log

Blockquote
Wrapper (Version 3.2.3) http://wrapper.tanukisoftware.org
Copyright 1999-2006 Tanuki Software, Inc. All Rights Reserved.

2021.04.06 11:47:50 INFO app[o.s.a.AppFileSystem] Cleaning or creating temp directory /opt/sonarqube/sonarqube/temp
2021.04.06 11:47:50 INFO app[o.s.a.es.EsSettings] Elasticsearch listening on [HTTP: 127.0.0.1:9001, TCP: 127.0.0.1:39151]
2021.04.06 11:47:50 INFO app[o.s.a.ProcessLauncherImpl] Launch process[[key=‘es’, ipcIndex=1, logFilenamePrefix=es]] from [/opt/sonarqube/sonarqube/elasticsearch]: /opt/sonarqube/sonarqube/elasticsearch/bin/elasticsearch
2021.04.06 11:47:50 INFO app[o.s.a.SchedulerImpl] Waiting for Elasticsearch to be up and running
OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
2021.04.06 11:47:58 INFO app[o.s.a.SchedulerImpl] Process[es] is up
2021.04.06 11:47:58 INFO app[o.s.a.ProcessLauncherImpl] Launch process[[key=‘web’, ipcIndex=2, logFilenamePrefix=web]] from [/opt/sonarqube/sonarqube]: /usr/lib/jvm/java-11-openjdk-amd64/bin/java -Djava.awt.headless=true -Dfile.encoding=UTF-8 -Djava.io.tmpdir=/opt/sonarqube/sonarqube/temp -XX:-OmitStackTraceInFastThrow --add-opens=java.base/java.util=ALL-UNNAMED --add-opens=java.base/java.lang=ALL-UNNAMED --add-opens=java.base/java.io=ALL-UNNAMED --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED -Xmx512m -Xms128m -XX:+HeapDumpOnOutOfMemoryError -Dhttp.nonProxyHosts=localhost|127.|[::1] -cp ./lib/common/:/opt/sonarqube/sonarqube/lib/jdbc/postgresql/postgresql-42.2.17.jar org.sonar.server.app.WebServer /opt/sonarqube/sonarqube/temp/sq-process2064465281867215905properties

web.log

root@ip-172-31-28-241:/opt/sonarqube/sonarqube/logs# tail -f web.log
at org.apache.commons.dbcp2.DriverConnectionFactory.createConnection(DriverConnectionFactory.java:55)
at org.apache.commons.dbcp2.PoolableConnectionFactory.makeObject(PoolableConnectionFactory.java:355)
at org.apache.commons.dbcp2.BasicDataSource.validateConnectionFactory(BasicDataSource.java:115)
at org.apache.commons.dbcp2.BasicDataSource.createPoolableConnectionFactory(BasicDataSource.java:665)
… 30 common frames omitted
2021.04.06 11:48:00 WARN web[o.a.c.l.WebappClassLoaderBase] The web application [ROOT] appears to have started a thread named [pool-1-thread-1] but has failed to stop it. This is very likely to create a memory leak. Stack trace of thread:\n java.base@11.0.10/sun.nio.ch.EPoll.wait(Native Method)\n java.base@11.0.10/sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:120)\n java.base@11.0.10/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)\n java.base@11.0.10/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136)\n app//org.apache.http.impl.nio.reactor.AbstractMultiworkerIOReactor.execute(AbstractMultiworkerIOReactor.java:343)\n app//org.apache.http.impl.nio.conn.PoolingNHttpClientConnectionManager.execute(PoolingNHttpClientConnectionManager.java:221)\n app//org.apache.http.impl.nio.client.CloseableHttpAsyncClientBase$1.run(CloseableHttpAsyncClientBase.java:64)\n java.base@11.0.10/java.lang.Thread.run(Thread.java:834)
2021.04.06 11:48:00 WARN web[o.a.c.l.WebappClassLoaderBase] The web application [ROOT] appears to have started a thread named [I/O dispatcher 1] but has failed to stop it. This is very likely to create a memory leak. Stack trace of thread:\n java.base@11.0.10/sun.nio.ch.EPoll.wait(Native Method)\n java.base@11.0.10/sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:120)\n java.base@11.0.10/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)\n java.base@11.0.10/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136)\n app//org.apache.http.impl.nio.reactor.AbstractIOReactor.execute(AbstractIOReactor.java:255)\n app//org.apache.http.impl.nio.reactor.BaseIOReactor.execute(BaseIOReactor.java:104)\n app//org.apache.http.impl.nio.reactor.AbstractMultiworkerIOReactor$Worker.run(AbstractMultiworkerIOReactor.java:591)\n java.base@11.0.10/java.lang.Thread.run(Thread.java:834)
2021.04.06 11:48:00 WARN web[o.a.c.l.WebappClassLoaderBase] The web application [ROOT] appears to have started a thread named [I/O dispatcher 2] but has failed to stop it. This is very likely to create a memory leak. Stack trace of thread:\n java.base@11.0.10/sun.nio.ch.EPoll.wait(Native Method)\n java.base@11.0.10/sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:120)\n java.base@11.0.10/sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:124)\n java.base@11.0.10/sun.nio.ch.SelectorImpl.select(SelectorImpl.java:136)\n app//org.apache.http.impl.nio.reactor.AbstractIOReactor.execute(AbstractIOReactor.java:255)\n app//org.apache.http.impl.nio.reactor.BaseIOReactor.execute(BaseIOReactor.java:104)\n app//org.apache.http.impl.nio.reactor.AbstractMultiworkerIOReactor$Worker.run(AbstractMultiworkerIOReactor.java:591)\n java.base@11.0.10/java.lang.Thread.run(Thread.java:834)
2021.04.06 11:48:01 INFO web[o.s.s.a.EmbeddedTomcat] HTTP connector enabled on port 9000
2021.04.06 11:48:01 INFO web[o.s.p.ProcessEntryPoint] Hard stopping process

Colin · April 6, 2021, 12:48pm

Hey there.

By doing a tail, you’re only getting the last few lines. The issue is probably earlier in the log file.

Anand_Krishnamoorthy · April 6, 2021, 12:57pm

Hey Colin, where are you located? I owe you a big treat. I was only tailing and after viewing the whole log, I felt so dumb myself. I fixed and it’s up now. Thanks so much… BTW, I am running this on a Ubuntu, any latest step by step for Amazon Linux 2?

Colin · April 8, 2021, 1:10pm

Hey there.

There shouldn’t be much meaningful difference between flavors of Linux. Whatever guide you were following before (hopefully our Requirements and Install the Server documents) should have you well on your way.