[root@ec2 ~]# docker logs 19cdfcc7487b 08:18:53.319 [main] WARN org.sonar.application.JdbcSettings - JDBC URL is recommended to have the property 'useConfigs=maxPerformance' 2016.10.05 08:18:53 INFO app[o.s.a.AppFileSystem] Cleaning or creating temp directory /opt/sonarqube/temp 2016.10.05 08:18:53 INFO app[o.s.p.m.JavaProcessLauncher] Launch process[es]: /usr/lib/jvm/java-8-openjdk-amd64/jre/bin/java -Djava.awt.headless=true -Xmx1G -Xms256m -Xss256k -Djna.nosys=true -XX:+UseParNewGC -XX:+UseConcMarkSweepGC -XX:CMSInitiatingOccupancyFraction=75 -XX:+UseCMSInitiatingOccupancyOnly -XX:+HeapDumpOnOutOfMemoryError -Djava.io.tmpdir=/opt/sonarqube/temp -javaagent:/usr/lib/jvm/java-8-openjdk-amd64/jre/lib/management-agent.jar -cp ./lib/common/*:./lib/search/* org.sonar.search.SearchServer /opt/sonarqube/temp/sq-process6789612814207801573properties 2016.10.05 08:18:54 INFO es[o.s.p.ProcessEntryPoint] Starting es 2016.10.05 08:18:54 INFO es[o.s.s.EsSettings] Elasticsearch listening on /127.0.0.1:9001 2016.10.05 08:18:54 INFO es[o.elasticsearch.node] [sonar-1475655533101] version[2.3.3], pid[19], build[218bdf1/2016-05-17T15:40:04Z] 2016.10.05 08:18:54 INFO es[o.elasticsearch.node] [sonar-1475655533101] initializing ... 2016.10.05 08:18:54 INFO es[o.e.plugins] [sonar-1475655533101] modules [], plugins [], sites [] 2016.10.05 08:18:54 INFO es[o.elasticsearch.env] [sonar-1475655533101] using [1] data paths, mounts [[/opt/sonarqube/data (/dev/xvda1)]], net usable_space [6.6gb], net total_space [7.7gb], spins? [possibly], types [ext4] 2016.10.05 08:18:54 INFO es[o.elasticsearch.env] [sonar-1475655533101] heap size [1007.3mb], compressed ordinary object pointers [true] 2016.10.05 08:18:54 WARN es[o.elasticsearch.env] [sonar-1475655533101] max file descriptors [4096] for elasticsearch process likely too low, consider increasing to at least [65536] 2016.10.05 08:18:57 INFO es[o.elasticsearch.node] [sonar-1475655533101] initialized 2016.10.05 08:18:57 INFO es[o.elasticsearch.node] [sonar-1475655533101] starting ... 2016.10.05 08:18:57 INFO es[o.e.transport] [sonar-1475655533101] publish_address {127.0.0.1:9001}, bound_addresses {127.0.0.1:9001} 2016.10.05 08:18:57 INFO es[o.e.discovery] [sonar-1475655533101] sonarqube/dsHbWSzkQEOvL02zJFHgAA 2016.10.05 08:19:00 INFO es[o.e.cluster.service] [sonar-1475655533101] new_master {sonar-1475655533101}{dsHbWSzkQEOvL02zJFHgAA}{127.0.0.1}{127.0.0.1:9001}{rack_id=sonar-1475655533101}, reason: zen-disco-join(elected_as_master, [0] joins received) 2016.10.05 08:19:00 INFO es[o.elasticsearch.node] [sonar-1475655533101] started 2016.10.05 08:19:00 INFO es[o.e.gateway] [sonar-1475655533101] recovered [0] indices into cluster_state 2016.10.05 08:19:00 INFO app[o.s.p.m.Monitor] Process[es] is up 2016.10.05 08:19:00 INFO app[o.s.p.m.JavaProcessLauncher] Launch process[web]: /usr/lib/jvm/java-8-openjdk-amd64/jre/bin/java -Djava.awt.headless=true -Dfile.encoding=UTF-8 -Djruby.management.enabled=false -Djruby.compile.invokedynamic=false -Xmx512m -Xms128m -XX:+HeapDumpOnOutOfMemoryError -Djava.security.egd=file:/dev/./urandom -Djava.io.tmpdir=/opt/sonarqube/temp -javaagent:/usr/lib/jvm/java-8-openjdk-amd64/jre/lib/management-agent.jar -cp ./lib/common/*:./lib/server/*:/opt/sonarqube/lib/jdbc/mysql/mysql-connector-java-5.1.39.jar org.sonar.server.app.WebServer /opt/sonarqube/temp/sq-process8148539493127104612properties 2016.10.05 08:19:01 INFO web[o.s.p.ProcessEntryPoint] Starting web 2016.10.05 08:19:01 INFO web[o.s.s.a.TomcatContexts] Webapp directory: /opt/sonarqube/web 2016.10.05 08:19:02 INFO web[o.a.c.h.Http11NioProtocol] Initializing ProtocolHandler ["http-nio-0.0.0.0-9000"] 2016.10.05 08:19:02 INFO web[o.a.t.u.n.NioSelectorPool] Using a shared selector for servlet write/read 2016.10.05 08:19:03 INFO web[o.s.s.p.ServerImpl] SonarQube Server / 6.0 / 93442889cd219e78b028c7dcf51a30de74c987fe 2016.10.05 08:19:03 INFO web[o.sonar.db.Database] Create JDBC data source for jdbc:mysql://...........rds.amazonaws.com:3306/sonar?useUnicode=true&characterEncoding=utf8&rewriteBatchedStatements=true 2016.10.05 08:19:04 INFO web[o.s.s.p.DefaultServerFileSystem] SonarQube home: /opt/sonarqube 2016.10.05 08:19:04 INFO web[o.e.plugins] [sonar-1475655533101] modules [], plugins [], sites [] 2016.10.05 08:19:05 INFO web[o.s.d.c.MysqlCharsetHandler] Verify that database collation is case-sensitive 2016.10.05 08:19:05 INFO web[o.s.s.p.RailsAppsDeployer] Deploying Ruby on Rails applications 2016.10.05 08:19:06 INFO web[o.s.s.p.UpdateCenterClient] Update center: http://update.sonarsource.org/update-center.properties (no proxy) 2016.10.05 08:19:07 INFO web[o.s.s.e.IndexCreator] Create index tests 2016.10.05 08:19:07 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [tests] creating index, cause [api], templates [], shards [5]/[0], mappings [] 2016.10.05 08:19:07 INFO es[o.e.c.r.allocation] [sonar-1475655533101] Cluster health status changed from [RED] to [GREEN] (reason: [shards started [[tests][4]] ...]). 2016.10.05 08:19:07 INFO web[o.s.s.e.IndexCreator] Create type tests/test 2016.10.05 08:19:07 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [tests] create_mapping [test] 2016.10.05 08:19:07 INFO web[o.s.s.e.IndexCreator] Create index activities 2016.10.05 08:19:07 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] creating index, cause [api], templates [], shards [5]/[0], mappings [] 2016.10.05 08:19:08 INFO es[o.e.c.r.allocation] [sonar-1475655533101] Cluster health status changed from [RED] to [GREEN] (reason: [shards started [[activities][4]] ...]). 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create type activities/activity 2016.10.05 08:19:08 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] create_mapping [activity] 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create index rules 2016.10.05 08:19:08 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [rules] creating index, cause [api], templates [], shards [5]/[0], mappings [] 2016.10.05 08:19:08 INFO es[o.e.c.r.allocation] [sonar-1475655533101] Cluster health status changed from [RED] to [GREEN] (reason: [shards started [[rules][4], [rules][4]] ...]). 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create type rules/activeRule 2016.10.05 08:19:08 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [rules] create_mapping [activeRule] 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create type rules/rule 2016.10.05 08:19:08 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [rules] create_mapping [rule] 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create index issues 2016.10.05 08:19:08 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [issues] creating index, cause [api], templates [], shards [5]/[0], mappings [] 2016.10.05 08:19:08 INFO es[o.e.c.r.allocation] [sonar-1475655533101] Cluster health status changed from [RED] to [GREEN] (reason: [shards started [[issues][4]] ...]). 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create type issues/issue 2016.10.05 08:19:08 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [issues] create_mapping [issue] 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create type issues/authorization 2016.10.05 08:19:08 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [issues] create_mapping [authorization] 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create index users 2016.10.05 08:19:08 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [users] creating index, cause [api], templates [], shards [5]/[0], mappings [] 2016.10.05 08:19:08 INFO es[o.e.c.r.allocation] [sonar-1475655533101] Cluster health status changed from [RED] to [GREEN] (reason: [shards started [[users][4]] ...]). 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create type users/user 2016.10.05 08:19:08 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [users] create_mapping [user] 2016.10.05 08:19:08 INFO web[o.s.s.e.IndexCreator] Create index views 2016.10.05 08:19:09 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [views] creating index, cause [api], templates [], shards [5]/[0], mappings [] 2016.10.05 08:19:09 INFO es[o.e.c.r.allocation] [sonar-1475655533101] Cluster health status changed from [RED] to [GREEN] (reason: [shards started [[views][4]] ...]). 2016.10.05 08:19:09 INFO web[o.s.s.e.IndexCreator] Create type views/view 2016.10.05 08:19:09 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [views] create_mapping [view] 2016.10.05 08:19:09 INFO web[o.s.s.n.NotificationService] Notification service started (delay 60 sec.) 2016.10.05 08:19:09 INFO web[o.s.s.s.RegisterMetrics] Register metrics 2016.10.05 08:19:09 INFO web[o.s.s.r.RegisterRules] Register rules 2016.10.05 08:19:12 INFO app[o.s.p.m.Monitor] Process[web] is stopping 2016.10.05 08:19:12 INFO web[o.s.p.StopWatcher] Stopping process 2016.10.05 08:19:13 INFO web[o.s.s.q.RegisterQualityProfiles] Register quality profiles 2016.10.05 08:19:13 INFO web[o.s.s.s.RegisterNewMeasureFilters] Register measure filters 2016.10.05 08:19:13 INFO web[o.s.s.s.RegisterDashboards] Register dashboards 2016.10.05 08:19:13 INFO web[o.s.s.s.RegisterPermissionTemplates] Register permission templates 2016.10.05 08:19:13 INFO web[o.s.s.s.RenameDeprecatedPropertyKeys] Rename deprecated property keys 2016.10.05 08:19:13 INFO web[o.s.s.e.IndexerStartupTask] Index activities 2016.10.05 08:19:13 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:13 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:13 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO es[o.e.cluster.metadata] [sonar-1475655533101] [activities] update_mapping [activity] 2016.10.05 08:19:14 INFO web[o.s.s.e.IndexerStartupTask] Index issues 2016.10.05 08:19:23 INFO web[o.s.s.e.IndexerStartupTask] Index tests 2016.10.05 08:19:23 INFO web[o.s.s.e.IndexerStartupTask] Index users 2016.10.05 08:19:23 INFO web[o.s.s.e.IndexerStartupTask] Index views 2016.10.05 08:19:23 INFO web[jruby.rack] jruby 1.7.9 (ruby-1.8.7p370) 2013-12-06 87b108a on OpenJDK 64-Bit Server VM 1.8.0_102-8u102-b14.1-1~bpo8+1-b14 [linux-amd64] 2016.10.05 08:19:23 INFO web[jruby.rack] using a shared (threadsafe!) runtime 2016.10.05 08:19:33 INFO web[jruby.rack] keeping custom (config.logger) Rails logger instance 2016.10.05 08:19:33 INFO web[o.s.s.p.MasterServletFilter] Initializing servlet filter org.sonar.server.ws.WebServiceFilter@65d1f2c0 [pattern=org.sonar.api.web.ServletFilter$UrlPattern@5782bb63] 2016.10.05 08:19:33 INFO web[o.s.s.p.MasterServletFilter] Initializing servlet filter org.sonar.server.authentication.InitFilter@75816e14 [pattern=org.sonar.api.web.ServletFilter$UrlPattern@1f2cc596] 2016.10.05 08:19:33 INFO web[o.s.s.p.MasterServletFilter] Initializing servlet filter org.sonar.server.authentication.OAuth2CallbackFilter@40889d14 [pattern=org.sonar.api.web.ServletFilter$UrlPattern@3e87badf] 2016.10.05 08:19:33 INFO web[o.s.s.p.MasterServletFilter] Initializing servlet filter org.sonar.server.authentication.ws.LoginAction@272c6f54 [pattern=org.sonar.api.web.ServletFilter$UrlPattern@247e682c] 2016.10.05 08:19:33 INFO web[o.s.s.p.MasterServletFilter] Initializing servlet filter org.sonar.server.authentication.ws.ValidateAction@776c015b [pattern=org.sonar.api.web.ServletFilter$UrlPattern@33fe962d] 2016.10.05 08:19:33 INFO web[o.a.c.h.Http11NioProtocol] Starting ProtocolHandler ["http-nio-0.0.0.0-9000"] 2016.10.05 08:19:33 INFO web[o.s.s.a.TomcatAccessLog] Web server is started 2016.10.05 08:19:33 INFO web[o.a.c.h.Http11NioProtocol] Pausing ProtocolHandler ["http-nio-0.0.0.0-9000"] 2016.10.05 08:19:33 INFO web[o.s.s.a.EmbeddedTomcat] HTTP connector enabled on port 9000 2016.10.05 08:19:33 INFO web[o.s.s.n.NotificationService] Notification service stopped 2016.10.05 08:19:33 WARN web[o.a.c.l.WebappClassLoaderBase] The web application [ROOT] appears to have started a thread named [Abandoned connection cleanup thread] but has failed to stop it. This is very likely to create a memory leak. Stack trace of thread: java.lang.Object.wait(Native Method) java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143) com.mysql.jdbc.AbandonedConnectionCleanupThread.run(AbandonedConnectionCleanupThread.java:43) 2016.10.05 08:19:33 INFO web[o.a.c.h.Http11NioProtocol] Stopping ProtocolHandler ["http-nio-0.0.0.0-9000"] 2016.10.05 08:19:33 INFO web[o.a.c.h.Http11NioProtocol] Destroying ProtocolHandler ["http-nio-0.0.0.0-9000"] 2016.10.05 08:19:33 INFO web[o.s.s.a.TomcatAccessLog] Web server is stopped 2016.10.05 08:19:34 INFO app[o.s.p.m.Monitor] Process[web] is up 2016.10.05 08:19:34 INFO app[o.s.p.m.JavaProcessLauncher] Launch process[ce]: /usr/lib/jvm/java-8-openjdk-amd64/jre/bin/java -Djava.awt.headless=true -Dfile.encoding=UTF-8 -Xmx512m -Xms128m -XX:+HeapDumpOnOutOfMemoryError -Djava.io.tmpdir=/opt/sonarqube/temp -javaagent:/usr/lib/jvm/java-8-openjdk-amd64/jre/lib/management-agent.jar -cp ./lib/common/*:./lib/server/*:./lib/ce/*:/opt/sonarqube/lib/jdbc/mysql/mysql-connector-java-5.1.39.jar org.sonar.ce.app.CeServer /opt/sonarqube/temp/sq-process4111826124429753383properties 2016.10.05 08:19:34 INFO app[o.s.p.m.Monitor] Process[web] is stopped 2016.10.05 08:19:34 INFO app[o.s.p.m.Monitor] Process[es] is stopping 2016.10.05 08:19:34 INFO es[o.s.p.StopWatcher] Stopping process 2016.10.05 08:19:34 INFO es[o.elasticsearch.node] [sonar-1475655533101] stopping ... 2016.10.05 08:19:34 INFO es[o.elasticsearch.node] [sonar-1475655533101] stopped 2016.10.05 08:19:34 INFO es[o.elasticsearch.node] [sonar-1475655533101] closing ... 2016.10.05 08:19:34 INFO es[o.elasticsearch.node] [sonar-1475655533101] closed 2016.10.05 08:19:34 INFO ce[o.s.p.ProcessEntryPoint] Starting ce 2016.10.05 08:19:34 INFO ce[o.s.ce.app.CeServer] Compute Engine starting up... 2016.10.05 08:19:35 INFO ce[o.s.s.p.ServerImpl] SonarQube Server / 6.0 / 93442889cd219e78b028c7dcf51a30de74c987fe 2016.10.05 08:19:35 INFO app[o.s.p.m.Monitor] Process[es] is stopped 2016.10.05 08:19:35 INFO ce[o.sonar.db.Database] Create JDBC data source for jdbc:mysql://some_RDS_instance.rds.amazonaws.com:3306/sonar?useUnicode=true&characterEncoding=utf8&rewriteBatchedStatements=true