Problem with my SonarQube-5.6.6(LTS) with sonar-cxx-plugin-0.9.7 plugin.

135 views
Skip to first unread message

moha...@gmail.com

unread,
May 30, 2017, 5:30:19 AM5/30/17
to SonarQube

Hi Team,


I have problem with my SonarQube-5.6.6(LTS) with sonar-cxx-plugin-0.9.7 plugin.


Our Environment details as follows:

SonarQube Server Version - 5.6.6 (64-Bit).
Operating System – Ubuntu 14.04.5 LTS (64-bit).

Java Version - openjdk version "1.8.0_111"
mysql  Ver 14.14 Distrib 5.6.33, for debian-linux-gnu (x86_64) using  EditLine wrapper.
CXX Plugin Version - sonar-cxx-plugin-0.9.7


Problem Description:

Actually I have copied the mysql dumped file from sonarqube-5.1 server and I have restored successfully in my sonarqube-5.6.6 new server. Then I installed required latest plugins then migrated MYSQL DB (http://mysonarqubeserver:9000/setup as per guide.  Later when I tried to start the SonarQube service, It shows below error,


Note: Without - sonar-cxx-plugin-0.9.7, I am able to start the service. Also I have tried by dropping DB and again created New DB, Still the same problem persists. So kindly help me to fix the same.


Error Msg from sonar.log:-


--> Wrapper Started as Daemon
Launching a JVM...
Wrapper (Version 3.2.3) http://wrapper.tanukisoftware.org
  Copyright 1999-2006 Tanuki Software, Inc.  All Rights Reserved.

2017.05.30 11:52:37 INFO  app[o.s.a.AppFileSystem] Cleaning or creating temp directory /opt/sonarqube-5.6.6/temp
2017.05.30 11:52:37 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 -Djava.net.preferIPv4Stack=true -XX:+UseParNewGC -XX:+UseConcMarkSweepGC -XX:CMSInitiatingOccupancyFraction=75 -XX:+UseCMSInitiatingOccupancyOnly -XX:+HeapDumpOnOutOfMemoryError -Djava.io.tmpdir=/opt/sonarqube-5.6.6/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-5.6.6/temp/sq-process5902385802164608709properties
2017.05.30 11:52:38 INFO   es[o.s.p.ProcessEntryPoint]  Starting es
2017.05.30 11:52:38 INFO   es[o.s.s.EsSettings]  Elasticsearch listening on 127.0.0.1:9001
2017.05.30 11:52:38 INFO   es[o.elasticsearch.node]  [sonar-1496125357398] version[1.7.5], pid[3123], build[00f95f4/2016-02-02T09:55:30Z]
2017.05.30 11:52:38 INFO   es[o.elasticsearch.node]  [sonar-1496125357398] initializing ...
2017.05.30 11:52:38 INFO   es[o.e.plugins]  [sonar-1496125357398] loaded [], sites []
2017.05.30 11:52:39 INFO   es[o.elasticsearch.env]  [sonar-1496125357398] using [1] data paths, mounts [[/ (/dev/sda1)]], net usable_space [142.1gb], net total_space [180.9gb], types [ext4]
2017.05.30 11:52:40 WARN   es[o.e.bootstrap]  JNA not found. native methods will be disabled.
2017.05.30 11:52:40 INFO   es[o.elasticsearch.node]  [sonar-1496125357398] initialized
2017.05.30 11:52:40 INFO   es[o.elasticsearch.node]  [sonar-1496125357398] starting ...
2017.05.30 11:52:40 INFO   es[o.e.transport]  [sonar-1496125357398] bound_address {inet[/127.0.0.1:9001]}, publish_address {inet[/127.0.0.1:9001]}
2017.05.30 11:52:40 INFO   es[o.e.discovery]  [sonar-1496125357398] sonarqube/0jXN1UrQTc6v7_0Euc47Gw
2017.05.30 11:52:43 INFO   es[o.e.cluster.service]  [sonar-1496125357398] new_master [sonar-1496125357398][0jXN1UrQTc6v7_0Euc47Gw][Sonarqube-test.sisodomain.com][inet[/127.0.0.1:9001]]{rack_id=sonar-1496125357398}, reason: zen-disco-join (elected_as_master)
2017.05.30 11:52:43 INFO   es[o.elasticsearch.node]  [sonar-1496125357398] started
2017.05.30 11:52:43 INFO   es[o.e.gateway]  [sonar-1496125357398] recovered [0] indices into cluster_state
2017.05.30 11:52:44 INFO  app[o.s.p.m.Monitor] Process[es] is up
2017.05.30 11:52:44 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.net.preferIPv4Stack=true -Djava.io.tmpdir=/opt/sonarqube-5.6.6/temp -javaagent:/usr/lib/jvm/java-8-openjdk-amd64/jre/lib/management-agent.jar -cp ./lib/common/*:./lib/server/*:/opt/sonarqube-5.6.6/lib/jdbc/mysql/mysql-connector-java-5.1.35.jar org.sonar.server.app.WebServer /opt/sonarqube-5.6.6/temp/sq-process3373652985015558144properties
2017.05.30 11:52:44 INFO  web[o.s.p.ProcessEntryPoint] Starting web
2017.05.30 11:52:44 INFO  web[o.s.s.a.TomcatContexts] Webapp directory: /opt/sonarqube-5.6.6/web
2017.05.30 11:52:45 INFO  web[o.a.c.h.Http11NioProtocol] Initializing ProtocolHandler ["http-nio-107.108.4.211-9000"]
2017.05.30 11:52:45 INFO  web[o.a.t.u.n.NioSelectorPool] Using a shared selector for servlet write/read
2017.05.30 11:52:45 INFO  web[o.s.s.p.ServerImpl] SonarQube Server / 5.6.6 / e8e13145497bb920921ae4fe11b09f0903f1d298
2017.05.30 11:52:45 INFO  web[o.sonar.db.Database] Create JDBC data source for jdbc:mysql://107.108.4.211:3306/sonar?useUnicode=true&characterEncoding=utf8&rewriteBatchedStatements=true&useConfigs=maxPerformance
2017.05.30 11:52:47 WARN  web[o.s.s.p.DatabaseServerCompatibility] Database must be upgraded. Please backup database and browse /setup
2017.05.30 11:52:47 INFO  web[o.s.s.p.DefaultServerFileSystem] SonarQube home: /opt/sonarqube-5.6.6
2017.05.30 11:52:47 INFO  web[o.e.plugins] [sonar-1496125357398] loaded [], sites []
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Analysis Bootstrapper for Visual Studio Projects / 1.2 / debe8e3820709cb34658d23f4de77d65577d42b1
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Android / 1.1 / 9ab2bbcc83177e67c74d365f009bfe05bf38c7e3
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin C# / 5.10.1.1411 / 748a97f89a5327cbea5cfe1f8aebe87d073c74a0
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin C++ (Community) / 0.9.7 / d33354779a55e09c3af1066f240d8d36d948fb27
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Checkstyle / 3.6.1 /
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Clover / 3.1 / 7beaec203a3762e7e14601e4a47ed05c161ed163
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Cobertura / 1.7 / d14b7978322d19a2795286ebfed225a57b13c3af
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Crowd / 2.0 / 699040114c48411e968961b1caa61a83f89c8906
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Findbugs / 3.4.4 /
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Git / 1.2 / a713dd64daf8719ba4e7f551f9a1966c62690c17
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Groovy / 1.5 / dcbcd1eeb8f61c8351e5dd1e51e11e52d186df35
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin PMD / 2.6 / f419f834b4bea51f9b6da33517b7f6186db5c066
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin SVN / 1.4.0.522 / 1309b92a587d1c8fd55a2981c69ceadc1f79e79c
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin SonarJS / 3.0.0.4962 / d34263e00f57251f23fedeb41b6d76d740f6ba5c
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin SonarJava / 4.9.0.9858 / f04d72a01871c96235fa97e0b9c5582455f313da
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin SonarPHP / 2.10.0.2087 / b24a8fcb16d37cae2f8c6741141f4136c444851f
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin SonarPython / 1.8.0.1496 / 3fe3bc4d0273a5721ea2fb368dc45b1bb82fede3
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin SonarXML / 1.4.2.885 / c00dcd5ef9a01d552daed7e08b240de1be6d413f
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Sonargraph / 3.5
2017.05.30 11:52:48 INFO  web[o.s.s.p.ServerPluginRepository] Deploy plugin Widget Lab / 1.8.1 / 347da6958ec03f3ab72e911234210bd90200718c
2017.05.30 11:52:49 INFO  web[o.s.s.p.RailsAppsDeployer] Deploying Ruby on Rails applications
2017.05.30 11:52:49 INFO  web[o.s.s.p.Platform] DB needs migration, entering safe mode
2017.05.30 11:52:49 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_111-8u111-b14-3~14.04.1-b14 [linux-amd64]
2017.05.30 11:52:49 INFO  web[jruby.rack] using a shared (threadsafe!) runtime
2017.05.30 11:52:56 INFO  web[jruby.rack] keeping custom (config.logger) Rails logger instance
2017.05.30 11:52:56 INFO  web[o.a.c.h.Http11NioProtocol] Starting ProtocolHandler ["http-nio-107.108.4.211-9000"]
2017.05.30 11:52:56 INFO  web[o.s.s.a.TomcatAccessLog] Web server is started
2017.05.30 11:52:56 INFO  web[o.s.s.a.EmbeddedTomcat] HTTP connector enabled on port 9000
2017.05.30 11:52:57 INFO  app[o.s.p.m.Monitor] Process[web] is up
2017.05.30 11:52:57 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.net.preferIPv4Stack=true -Djava.io.tmpdir=/opt/sonarqube-5.6.6/temp -javaagent:/usr/lib/jvm/java-8-openjdk-amd64/jre/lib/management-agent.jar -cp ./lib/common/*:./lib/server/*:./lib/ce/*:/opt/sonarqube-5.6.6/lib/jdbc/mysql/mysql-connector-java-5.1.35.jar org.sonar.ce.app.CeServer /opt/sonarqube-5.6.6/temp/sq-process8572611245466180871properties
2017.05.30 11:52:57 INFO  ce[o.s.p.ProcessEntryPoint] Starting ce
2017.05.30 11:52:57 INFO  ce[o.s.c.a.WebServerWatcherImpl] Waiting for Web Server to be operational...
2017.05.30 11:52:58 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 11:53:00 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 11:53:05 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 11:53:18 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 11:53:52 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 11:54:25 INFO  web[o.s.s.d.m.PlatformDatabaseMigration] Starting DB Migration
2017.05.30 11:54:25 INFO  web[DbMigration] ==  AddProjectLinksComponentUuid: migrating ===================================
2017.05.30 11:54:25 INFO  web[DbMigration] -- columns("project_links")
2017.05.30 11:54:25 INFO  web[DbMigration]    -> 0.0130s
2017.05.30 11:54:25 INFO  web[DbMigration] -- add_column("project_links", "component_uuid", :string, {:limit=>50})
2017.05.30 11:54:25 INFO  web[DbMigration]    -> 0.0570s
2017.05.30 11:54:25 INFO  web[DbMigration]    -> 0 rows
2017.05.30 11:54:25 INFO  web[DbMigration] ==  AddProjectLinksComponentUuid: migrated (0.0730s) ==========================
2017.05.30 11:54:25 INFO  web[DbMigration]
2017.05.30 11:54:25 INFO  web[DbMigration] ==  FeedProjectLinksComponentUuid: migrating ==================================
2017.05.30 11:54:25 INFO  web[o.s.d.v.MassUpdate] 33 project links processed (0 items/sec)
2017.05.30 11:54:25 INFO  web[DbMigration] ==  FeedProjectLinksComponentUuid: migrated (0.0430s) =========================
2017.05.30 11:54:25 INFO  web[DbMigration]
2017.05.30 11:54:25 INFO  web[DbMigration] ==  RemoveProjectLinksProjectId: migrating ====================================
2017.05.30 11:54:25 INFO  web[DbMigration] -- columns("project_links")
2017.05.30 11:54:25 INFO  web[DbMigration]    -> 0.0060s
2017.05.30 11:54:25 INFO  web[DbMigration] -- remove_column("project_links", "project_id")
2017.05.30 11:54:25 INFO  web[DbMigration]    -> 0.0320s
2017.05.30 11:54:25 INFO  web[DbMigration] ==  RemoveProjectLinksProjectId: migrated (0.0400s) ===========================
2017.05.30 11:54:25 INFO  web[DbMigration]
2017.05.30 11:54:25 INFO  web[DbMigration] ==  AddEventsComponentUuid: migrating =========================================
2017.05.30 11:54:25 INFO  web[DbMigration] -- columns("events")
2017.05.30 11:54:25 INFO  web[DbMigration]    -> 0.0180s
2017.05.30 11:54:25 INFO  web[DbMigration] -- add_column("events", "component_uuid", :string, {:limit=>50})
2017.05.30 11:54:26 INFO  web[DbMigration]    -> 0.1950s
2017.05.30 11:54:26 INFO  web[DbMigration]    -> 0 rows
2017.05.30 11:54:26 INFO  web[DbMigration] -- index_exists?("events", "component_uuid", {:name=>"events_component_uuid"})
2017.05.30 11:54:26 INFO  web[DbMigration]    -> 0.0060s
2017.05.30 11:54:26 INFO  web[DbMigration] -- add_index("events", "component_uuid", {:name=>"events_component_uuid"})
2017.05.30 11:54:26 INFO  web[DbMigration]    -> 0.0400s
2017.05.30 11:54:26 INFO  web[DbMigration]    -> 0 rows
2017.05.30 11:54:26 INFO  web[DbMigration] ==  AddEventsComponentUuid: migrated (0.2670s) ================================
2017.05.30 11:54:26 INFO  web[DbMigration]
2017.05.30 11:54:26 INFO  web[DbMigration] ==  FeedEventsComponentUuid: migrating ========================================
2017.05.30 11:54:26 INFO  web[o.s.d.v.MassUpdate] 3326 events processed (55 items/sec)
2017.05.30 11:54:26 INFO  web[DbMigration] ==  FeedEventsComponentUuid: migrated (0.8380s) ===============================
2017.05.30 11:54:26 INFO  web[DbMigration]
2017.05.30 11:54:26 INFO  web[DbMigration] ==  RemoveEventsResourceId: migrating =========================================
2017.05.30 11:54:26 INFO  web[DbMigration] -- remove_index("events", {:name=>"events_resource_id"})
2017.05.30 11:54:26 INFO  web[DbMigration]    -> 0.0090s
2017.05.30 11:54:26 INFO  web[DbMigration]    -> 0 rows
2017.05.30 11:54:26 INFO  web[DbMigration] -- columns("events")
2017.05.30 11:54:26 INFO  web[DbMigration]    -> 0.0070s
2017.05.30 11:54:26 INFO  web[DbMigration] -- remove_column("events", "resource_id")
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0.1650s
2017.05.30 11:54:27 INFO  web[DbMigration] ==  RemoveEventsResourceId: migrated (0.1850s) ================================
2017.05.30 11:54:27 INFO  web[DbMigration]
2017.05.30 11:54:27 INFO  web[DbMigration] ==  CreateProjectProfiles: migrating ==========================================
2017.05.30 11:54:27 INFO  web[DbMigration] -- create_table(:project_qprofiles, {})
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0.0130s
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 11:54:27 INFO  web[DbMigration] -- index_exists?("project_qprofiles", ["project_uuid", "profile_key"], {:name=>"uniq_project_qprofiles"})
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 11:54:27 INFO  web[DbMigration] -- add_index("project_qprofiles", ["project_uuid", "profile_key"], {:unique=>true, :name=>"uniq_project_qprofiles"})
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0.0090s
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 11:54:27 INFO  web[DbMigration] ==  CreateProjectProfiles: migrated (0.0280s) =================================
2017.05.30 11:54:27 INFO  web[DbMigration]
2017.05.30 11:54:27 INFO  web[DbMigration] ==  AddRulesProfilesIsDefault: migrating ======================================
2017.05.30 11:54:27 INFO  web[DbMigration] -- columns("rules_profiles")
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0.0060s
2017.05.30 11:54:27 INFO  web[DbMigration] -- add_column("rules_profiles", "is_default", :boolean, {:null=>false, :default=>false})
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0.0610s
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 11:54:27 INFO  web[DbMigration] ==  AddRulesProfilesIsDefault: migrated (0.0690s) =============================
2017.05.30 11:54:27 INFO  web[DbMigration]
2017.05.30 11:54:27 INFO  web[DbMigration] ==  MoveProjectProfileAssociation: migrating ==================================
2017.05.30 11:54:27 INFO  web[o.s.d.v.MassUpdate] 32 rows processed (0 items/sec)
2017.05.30 11:54:27 INFO  web[DbMigration] ==  MoveProjectProfileAssociation: migrated (0.0300s) =========================
2017.05.30 11:54:27 INFO  web[DbMigration]
2017.05.30 11:54:27 INFO  web[DbMigration] ==  AddFileSourcesDataType: migrating =========================================
2017.05.30 11:54:27 INFO  web[DbMigration] -- columns("file_sources")
2017.05.30 11:54:27 INFO  web[DbMigration]    -> 0.0070s
2017.05.30 11:54:27 INFO  web[DbMigration] -- add_column("file_sources", "data_type", :string, {:limit=>20})
2017.05.30 11:55:27 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 11:59:42 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 12:03:46 INFO  web[DbMigration]    -> 559.6180s
2017.05.30 12:03:46 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:03:46 INFO  web[DbMigration] -- change_column("file_sources", "data_hash", :string, {:limit=>50, :null=>true})
2017.05.30 12:03:46 INFO  web[DbMigration]    -> 0.0110s
2017.05.30 12:03:46 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:03:46 INFO  web[DbMigration] -- remove_index("file_sources", {:name=>"file_sources_file_uuid_uniq"})
2017.05.30 12:03:46 INFO  web[DbMigration]    -> 0.0150s
2017.05.30 12:03:46 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:03:46 INFO  web[DbMigration] -- index_exists?("file_sources", ["file_uuid", "data_type"], {:name=>"file_sources_uuid_type"})
2017.05.30 12:03:46 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 12:03:46 INFO  web[DbMigration] -- add_index("file_sources", ["file_uuid", "data_type"], {:name=>"file_sources_uuid_type", :unique=>true})
2017.05.30 12:03:51 INFO  web[DbMigration]    -> 4.1980s
2017.05.30 12:03:51 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:03:51 INFO  web[DbMigration] ==  AddFileSourcesDataType: migrated (563.8560s) ==============================
2017.05.30 12:03:51 INFO  web[DbMigration]
2017.05.30 12:03:51 INFO  web[DbMigration] ==  FeedFileSourcesDataType: migrating ========================================
2017.05.30 12:04:27 INFO  web[DbMigration] ==  FeedFileSourcesDataType: migrated (36.4260s) ==============================
2017.05.30 12:04:27 INFO  web[DbMigration]
2017.05.30 12:04:27 INFO  web[DbMigration] ==  DropTableGraphs: migrating ================================================
2017.05.30 12:04:27 INFO  web[DbMigration] -- remove_index("graphs", {:name=>"graphs_perspectives"})
2017.05.30 12:04:27 INFO  web[DbMigration]    -> 0.0900s
2017.05.30 12:04:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:27 INFO  web[DbMigration] -- drop_table("graphs")
2017.05.30 12:04:27 INFO  web[DbMigration]    -> 0.0430s
2017.05.30 12:04:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:27 INFO  web[DbMigration] ==  DropTableGraphs: migrated (0.1360s) =======================================
2017.05.30 12:04:27 INFO  web[DbMigration]
2017.05.30 12:04:27 INFO  web[DbMigration] ==  FeedMetricsBooleans: migrating ============================================
2017.05.30 12:04:27 INFO  web[DbMigration] ==  FeedMetricsBooleans: migrated (0.0200s) ===================================
2017.05.30 12:04:27 INFO  web[DbMigration]
2017.05.30 12:04:27 INFO  web[DbMigration] ==  RemoveMetricsOrigin: migrating ============================================
2017.05.30 12:04:27 INFO  web[DbMigration] -- columns("metrics")
2017.05.30 12:04:27 INFO  web[DbMigration]    -> 0.0150s
2017.05.30 12:04:27 INFO  web[DbMigration] -- remove_column("metrics", "origin")
2017.05.30 12:04:28 INFO  web[DbMigration]    -> 0.2340s
2017.05.30 12:04:28 INFO  web[DbMigration] ==  RemoveMetricsOrigin: migrated (0.2500s) ===================================
2017.05.30 12:04:28 INFO  web[DbMigration]
2017.05.30 12:04:28 INFO  web[DbMigration] ==  AddManualMeasuresComponentUuid: migrating =================================
2017.05.30 12:04:28 INFO  web[DbMigration] -- index_exists?("manual_measures", "component_uuid", {:name=>"manual_measures_component_uuid"})
2017.05.30 12:04:28 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 12:04:28 INFO  web[DbMigration] -- add_index("manual_measures", "component_uuid", {:name=>"manual_measures_component_uuid"})
2017.05.30 12:04:28 INFO  web[DbMigration]    -> 0.1350s
2017.05.30 12:04:28 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:28 INFO  web[DbMigration] ==  AddManualMeasuresComponentUuid: migrated (0.2120s) ========================
2017.05.30 12:04:28 INFO  web[DbMigration]
2017.05.30 12:04:28 INFO  web[DbMigration] ==  FeedManualMeasuresComponentUuid: migrating ================================
2017.05.30 12:04:28 INFO  web[o.s.d.v.MassUpdate] 0 manual measures processed (0 items/sec)
2017.05.30 12:04:28 INFO  web[DbMigration] ==  FeedManualMeasuresComponentUuid: migrated (0.0070s) =======================
2017.05.30 12:04:28 INFO  web[DbMigration]
2017.05.30 12:04:28 INFO  web[DbMigration] ==  RemoveSnapshotLibraries: migrating ========================================
2017.05.30 12:04:28 INFO  web[o.s.d.v.MassUpdate] 926 snapshot libraries processed (15 items/sec)
2017.05.30 12:04:28 INFO  web[DbMigration] ==  RemoveSnapshotLibraries: migrated (0.3860s) ===============================
2017.05.30 12:04:28 INFO  web[DbMigration]
2017.05.30 12:04:28 INFO  web[DbMigration] ==  RemoveComponentLibraries: migrating =======================================
2017.05.30 12:04:30 INFO  web[o.s.d.v.MassUpdate] 446 component libraries processed (7 items/sec)
2017.05.30 12:04:30 INFO  web[DbMigration] ==  RemoveComponentLibraries: migrated (1.4620s) ==============================
2017.05.30 12:04:30 INFO  web[DbMigration]
2017.05.30 12:04:30 INFO  web[DbMigration] ==  DropTableDependencies: migrating ==========================================
2017.05.30 12:04:30 INFO  web[DbMigration] -- remove_index("dependencies", {:name=>"deps_from_sid"})
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0.0440s
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:30 INFO  web[DbMigration] -- remove_index("dependencies", {:name=>"deps_prj_sid"})
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0.0080s
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:30 INFO  web[DbMigration] -- remove_index("dependencies", {:name=>"deps_to_sid"})
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0.0090s
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:30 INFO  web[DbMigration] -- drop_table("dependencies")
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0.0070s
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:30 INFO  web[DbMigration] ==  DropTableDependencies: migrated (0.0690s) =================================
2017.05.30 12:04:30 INFO  web[DbMigration]
2017.05.30 12:04:30 INFO  web[DbMigration] ==  RemoveManualMeasuresResourceId: migrating =================================
2017.05.30 12:04:30 INFO  web[DbMigration] -- remove_index("manual_measures", {:name=>"manual_measures_resource_id"})
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0.0090s
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:30 INFO  web[DbMigration] -- columns("manual_measures")
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0.0050s
2017.05.30 12:04:30 INFO  web[DbMigration] -- remove_column("manual_measures", "resource_id")
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0.0230s
2017.05.30 12:04:30 INFO  web[DbMigration] ==  RemoveManualMeasuresResourceId: migrated (0.0390s) ========================
2017.05.30 12:04:30 INFO  web[DbMigration]
2017.05.30 12:04:30 INFO  web[DbMigration] ==  DropSemaphores: migrating =================================================
2017.05.30 12:04:30 INFO  web[DbMigration] -- remove_index(:semaphores, {:name=>"uniq_semaphore_checksums"})
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0.0090s
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:30 INFO  web[DbMigration] -- drop_table("semaphores")
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0.0090s
2017.05.30 12:04:30 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:30 INFO  web[DbMigration] ==  DropSemaphores: migrated (0.0190s) ========================================
2017.05.30 12:04:30 INFO  web[DbMigration]
2017.05.30 12:04:30 INFO  web[DbMigration] ==  RemoveDuplicatedComponentKeys: migrating ==================================
2017.05.30 12:04:41 INFO  web[o.s.d.v.v.RemoveDuplicatedComponentKeys] 0 rows processed (0 items/sec)
2017.05.30 12:04:41 INFO  web[DbMigration] ==  RemoveDuplicatedComponentKeys: migrated (10.8740s) ========================
2017.05.30 12:04:41 INFO  web[DbMigration]
2017.05.30 12:04:41 INFO  web[DbMigration] ==  UpdateProjectsKeeIndex: migrating =========================================
2017.05.30 12:04:41 INFO  web[DbMigration] -- remove_index(:projects, {:name=>"projects_kee"})
2017.05.30 12:04:41 INFO  web[DbMigration]    -> 0.0220s
2017.05.30 12:04:41 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:41 INFO  web[DbMigration] -- index_exists?(:projects, :kee, {:name=>"projects_kee"})
2017.05.30 12:04:41 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 12:04:41 INFO  web[DbMigration] -- add_index(:projects, :kee, {:name=>"projects_kee", :length=>{:kee=>255}})
2017.05.30 12:04:49 INFO  web[DbMigration]    -> 8.2070s
2017.05.30 12:04:49 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:04:49 INFO  web[DbMigration] ==  UpdateProjectsKeeIndex: migrated (8.2320s) ================================
2017.05.30 12:04:49 INFO  web[DbMigration]
2017.05.30 12:04:49 INFO  web[DbMigration] ==  AddIssuesLocations: migrating =============================================
2017.05.30 12:04:49 INFO  web[DbMigration] -- columns("issues")
2017.05.30 12:04:49 INFO  web[DbMigration]    -> 0.0210s
2017.05.30 12:04:49 INFO  web[DbMigration] -- add_column("issues", "locations", :binary, {:null=>true})
2017.05.30 12:11:15 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 12:40:44 INFO  web[DbMigration]    -> 2155.3080s
2017.05.30 12:40:44 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:40:44 INFO  web[DbMigration] ==  AddIssuesLocations: migrated (2155.3310s) =================================
2017.05.30 12:40:44 INFO  web[DbMigration]
2017.05.30 12:40:45 INFO  web[DbMigration] ==  AddCommitInFileSources: migrating =========================================
2017.05.30 12:40:45 INFO  web[DbMigration] -- columns("file_sources")
2017.05.30 12:40:45 INFO  web[DbMigration]    -> 0.0050s
2017.05.30 12:40:45 INFO  web[DbMigration] -- add_column("file_sources", "revision", :string, {:limit=>100})
2017.05.30 12:42:40 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 12:48:05 INFO  web[DbMigration]    -> 440.4360s
2017.05.30 12:48:05 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:48:05 INFO  web[DbMigration] ==  AddCommitInFileSources: migrated (440.4420s) ==============================
2017.05.30 12:48:05 INFO  web[DbMigration]
2017.05.30 12:48:05 INFO  web[DbMigration] ==  AddProjectsQualifierIndex: migrating ======================================
2017.05.30 12:48:05 INFO  web[DbMigration] -- index_exists?("projects", "qualifier", {:name=>"projects_qualifier"})
2017.05.30 12:48:05 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 12:48:05 INFO  web[DbMigration] -- add_index("projects", "qualifier", {:name=>"projects_qualifier"})
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 15.1340s
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:48:20 INFO  web[DbMigration] ==  AddProjectsQualifierIndex: migrated (15.1370s) ============================
2017.05.30 12:48:20 INFO  web[DbMigration]
2017.05.30 12:48:20 INFO  web[DbMigration] ==  CreateCeActivity: migrating ===============================================
2017.05.30 12:48:20 INFO  web[DbMigration] -- create_table("ce_activity", {})
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0.0500s
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:48:20 INFO  web[DbMigration] -- index_exists?("ce_activity", "uuid", {:name=>"ce_activity_uuid"})
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 12:48:20 INFO  web[DbMigration] -- add_index("ce_activity", "uuid", {:name=>"ce_activity_uuid", :unique=>true})
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0.0180s
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:48:20 INFO  web[DbMigration] -- index_exists?("ce_activity", "component_uuid", {:name=>"ce_activity_component_uuid"})
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0.0010s
2017.05.30 12:48:20 INFO  web[DbMigration] -- add_index("ce_activity", "component_uuid", {:name=>"ce_activity_component_uuid"})
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0.0420s
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:48:20 INFO  web[DbMigration] ==  CreateCeActivity: migrated (0.1150s) ======================================
2017.05.30 12:48:20 INFO  web[DbMigration]
2017.05.30 12:48:20 INFO  web[DbMigration] ==  CreateCeQueue: migrating ==================================================
2017.05.30 12:48:20 INFO  web[DbMigration] -- create_table("ce_queue", {})
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0.0320s
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:48:20 INFO  web[DbMigration] -- index_exists?("ce_queue", "uuid", {:name=>"ce_queue_uuid"})
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0.0010s
2017.05.30 12:48:20 INFO  web[DbMigration] -- add_index("ce_queue", "uuid", {:name=>"ce_queue_uuid", :unique=>true})
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0.0250s
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:48:20 INFO  web[DbMigration] ==  CreateCeQueue: migrated (0.0640s) =========================================
2017.05.30 12:48:20 INFO  web[DbMigration]
2017.05.30 12:48:20 INFO  web[DbMigration] ==  DropTableAnalysisReports: migrating =======================================
2017.05.30 12:48:20 INFO  web[DbMigration] -- drop_table("analysis_reports")
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0.0630s
2017.05.30 12:48:20 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:48:20 INFO  web[DbMigration] ==  DropTableAnalysisReports: migrated (0.0630s) ==============================
2017.05.30 12:48:20 INFO  web[DbMigration]
2017.05.30 12:48:20 INFO  web[DbMigration] ==  RemoveAnalysisReportsFromActivities: migrating ============================
2017.05.30 12:48:23 INFO  web[o.s.d.v.MassUpdate] 16155 rows processed (269 items/sec)
2017.05.30 12:48:23 INFO  web[DbMigration] ==  RemoveAnalysisReportsFromActivities: migrated (2.9680s) ===================
2017.05.30 12:48:23 INFO  web[DbMigration]
2017.05.30 12:48:23 INFO  web[DbMigration] ==  AddProvisioningPermissionToScan: migrating ================================
2017.05.30 12:48:24 INFO  web[DbMigration] ==  AddProvisioningPermissionToScan: migrated (0.1610s) =======================
2017.05.30 12:48:24 INFO  web[DbMigration]
2017.05.30 12:48:24 INFO  web[DbMigration] ==  DeletePropertyPreventAutoProjectCreation: migrating =======================
2017.05.30 12:48:24 INFO  web[DbMigration] ==  DeletePropertyPreventAutoProjectCreation: migrated (0.0000s) ==============
2017.05.30 12:48:24 INFO  web[DbMigration]
2017.05.30 12:48:24 INFO  web[DbMigration] ==  IncreasePrecisionOfNumerics: migrating ====================================
2017.05.30 12:53:38 INFO  web[DbMigration] ==  IncreasePrecisionOfNumerics: migrated (314.2060s) =========================
2017.05.30 12:53:38 INFO  web[DbMigration]
2017.05.30 12:53:38 INFO  web[DbMigration] ==  RemoveRuleMeasuresOnIssues: migrating =====================================
2017.05.30 12:54:38 INFO  web[o.s.d.v.MassUpdate] 280749 measures processed (4679 items/sec)
2017.05.30 12:55:38 INFO  web[o.s.d.v.MassUpdate] 599749 measures processed (5316 items/sec)
2017.05.30 12:56:38 INFO  web[o.s.d.v.MassUpdate] 918749 measures processed (5316 items/sec)
2017.05.30 12:57:38 INFO  web[o.s.d.v.MassUpdate] 1183749 measures processed (4416 items/sec)
2017.05.30 12:58:25 INFO  web[o.s.d.v.MassUpdate] 1363050 measures processed (2988 items/sec)
2017.05.30 12:58:25 INFO  web[DbMigration] ==  RemoveRuleMeasuresOnIssues: migrated (286.8500s) ==========================
2017.05.30 12:58:25 INFO  web[DbMigration]
2017.05.30 12:58:25 INFO  web[DbMigration] ==  MoveDuplicationsIdToBigint: migrating =====================================
2017.05.30 12:58:25 INFO  web[DbMigration] -- execute("ALTER TABLE duplications_index CHANGE id id BIGINT AUTO_INCREMENT")
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0.0500s
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:25 INFO  web[DbMigration] ==  MoveDuplicationsIdToBigint: migrated (0.0510s) ============================
2017.05.30 12:58:25 INFO  web[DbMigration]
2017.05.30 12:58:25 INFO  web[DbMigration] ==  DeleteTechnicalDebtSizeMetric: migrating ==================================
2017.05.30 12:58:25 INFO  web[DbMigration] ==  DeleteTechnicalDebtSizeMetric: migrated (0.0160s) =========================
2017.05.30 12:58:25 INFO  web[DbMigration]
2017.05.30 12:58:25 INFO  web[DbMigration] ==  AlterIssuesCharColumnsOnMssql: migrating ==================================
2017.05.30 12:58:25 INFO  web[DbMigration] ==  AlterIssuesCharColumnsOnMssql: migrated (0.0000s) =========================
2017.05.30 12:58:25 INFO  web[DbMigration]
2017.05.30 12:58:25 INFO  web[DbMigration] ==  CreateUserTokens: migrating ===============================================
2017.05.30 12:58:25 INFO  web[DbMigration] -- create_table("user_tokens", {})
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0.0140s
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:25 INFO  web[DbMigration] -- index_exists?("user_tokens", "token_hash", {:name=>"user_tokens_token_hash"})
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 12:58:25 INFO  web[DbMigration] -- add_index("user_tokens", "token_hash", {:name=>"user_tokens_token_hash", :unique=>true})
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0.0090s
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:25 INFO  web[DbMigration] -- index_exists?("user_tokens", ["login", "name"], {:name=>"user_tokens_login_name"})
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 12:58:25 INFO  web[DbMigration] -- add_index("user_tokens", ["login", "name"], {:name=>"user_tokens_login_name", :unique=>true})
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0.0100s
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:25 INFO  web[DbMigration] ==  CreateUserTokens: migrated (0.0370s) ======================================
2017.05.30 12:58:25 INFO  web[DbMigration]
2017.05.30 12:58:25 INFO  web[DbMigration] ==  FixSizeOfSnapshotsQualifier: migrating ====================================
2017.05.30 12:58:25 INFO  web[DbMigration] -- remove_index(:snapshots, {:name=>"snapshots_qualifier"})
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0.0420s
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:25 INFO  web[DbMigration] -- change_column("snapshots", "qualifier", :string, {:limit=>10, :null=>true})
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0.0100s
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:25 INFO  web[DbMigration] -- index_exists?(:snapshots, :qualifier, {:name=>"snapshots_qualifier"})
2017.05.30 12:58:25 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 12:58:25 INFO  web[DbMigration] -- add_index(:snapshots, :qualifier, {:name=>"snapshots_qualifier"})
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 1.6950s
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:27 INFO  web[DbMigration] ==  FixSizeOfSnapshotsQualifier: migrated (1.7490s) ===========================
2017.05.30 12:58:27 INFO  web[DbMigration]
2017.05.30 12:58:27 INFO  web[DbMigration] ==  AddIndexOnCeActivityIsLastKey: migrating ==================================
2017.05.30 12:58:27 INFO  web[DbMigration] -- index_exists?(:ce_activity, :is_last_key, {:name=>"ce_activity_islastkey"})
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0.0030s
2017.05.30 12:58:27 INFO  web[DbMigration] -- add_index(:ce_activity, :is_last_key, {:name=>"ce_activity_islastkey"})
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0.0100s
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:27 INFO  web[DbMigration] ==  AddIndexOnCeActivityIsLastKey: migrated (0.0130s) =========================
2017.05.30 12:58:27 INFO  web[DbMigration]
2017.05.30 12:58:27 INFO  web[DbMigration] ==  AddCeActivitySnapshotId: migrating ========================================
2017.05.30 12:58:27 INFO  web[DbMigration] -- columns("ce_activity")
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0.0050s
2017.05.30 12:58:27 INFO  web[DbMigration] -- add_column("ce_activity", :snapshot_id, :big_integer, {:null=>true})
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0.0220s
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:27 INFO  web[DbMigration] ==  AddCeActivitySnapshotId: migrated (0.0270s) ===============================
2017.05.30 12:58:27 INFO  web[DbMigration]
2017.05.30 12:58:27 INFO  web[DbMigration] ==  AddDecimalScaleToMetrics: migrating =======================================
2017.05.30 12:58:27 INFO  web[DbMigration] -- columns("metrics")
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0.0050s
2017.05.30 12:58:27 INFO  web[DbMigration] -- add_column("metrics", "decimal_scale", :integer, {:null=>true})
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0.0440s
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:27 INFO  web[DbMigration] ==  AddDecimalScaleToMetrics: migrated (0.0490s) ==============================
2017.05.30 12:58:27 INFO  web[DbMigration]
2017.05.30 12:58:27 INFO  web[DbMigration] ==  UpdateCustomDashboardInLoadedTemplates: migrating =========================
2017.05.30 12:58:27 INFO  web[o.s.d.v.MassUpdate] 1 loaded templates processed (0 items/sec)
2017.05.30 12:58:27 INFO  web[DbMigration] ==  UpdateCustomDashboardInLoadedTemplates: migrated (0.0240s) ================
2017.05.30 12:58:27 INFO  web[DbMigration]
2017.05.30 12:58:27 INFO  web[DbMigration] ==  AddIndexOnCeQueueComponentUuid: migrating =================================
2017.05.30 12:58:27 INFO  web[DbMigration] -- index_exists?(:ce_queue, :component_uuid, {:name=>"ce_queue_component_uuid"})
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0.0010s
2017.05.30 12:58:27 INFO  web[DbMigration] -- add_index(:ce_queue, :component_uuid, {:name=>"ce_queue_component_uuid"})
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0.0100s
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:27 INFO  web[DbMigration] ==  AddIndexOnCeQueueComponentUuid: migrated (0.0130s) ========================
2017.05.30 12:58:27 INFO  web[DbMigration]
2017.05.30 12:58:27 INFO  web[DbMigration] ==  InsertGateAdminPermissionForEachProfileAdmin: migrating ===================
2017.05.30 12:58:27 INFO  web[o.s.d.v.MassUpdate] 0 Group AnyOne processed (0 items/sec)
2017.05.30 12:58:27 INFO  web[o.s.d.v.MassUpdate] 1 Other groups processed (0 items/sec)
2017.05.30 12:58:27 INFO  web[o.s.d.v.MassUpdate] 2 Users processed (0 items/sec)
2017.05.30 12:58:27 INFO  web[DbMigration] ==  InsertGateAdminPermissionForEachProfileAdmin: migrated (0.0500s) ==========
2017.05.30 12:58:27 INFO  web[DbMigration]
2017.05.30 12:58:27 INFO  web[DbMigration] ==  RemoveComponentPageProperties: migrating ==================================
2017.05.30 12:58:27 INFO  web[o.s.d.v.MassUpdate] 1 properties for deleted component page processed (0 items/sec)
2017.05.30 12:58:27 INFO  web[DbMigration] ==  RemoveComponentPageProperties: migrated (0.0050s) =========================
2017.05.30 12:58:27 INFO  web[DbMigration]
2017.05.30 12:58:27 INFO  web[DbMigration] ==  AddIndexMeasuresPersonId: migrating =======================================
2017.05.30 12:58:27 INFO  web[DbMigration] -- index_exists?(:project_measures, :person_id, {:name=>"measures_person"})
2017.05.30 12:58:27 INFO  web[DbMigration]    -> 0.0010s
2017.05.30 12:58:27 INFO  web[DbMigration] -- add_index(:project_measures, :person_id, {:name=>"measures_person"})
2017.05.30 12:58:49 INFO  web[DbMigration]    -> 22.6320s
2017.05.30 12:58:49 INFO  web[DbMigration]    -> 0 rows
2017.05.30 12:58:49 INFO  web[DbMigration] ==  AddIndexMeasuresPersonId: migrated (22.6350s) =============================
2017.05.30 12:58:49 INFO  web[DbMigration]
2017.05.30 12:58:49 INFO  web[DbMigration] ==  AddUsersIdentityColumns: migrating ========================================
2017.05.30 12:58:50 INFO  web[DbMigration] ==  AddUsersIdentityColumns: migrated (0.3770s) ===============================
2017.05.30 12:58:50 INFO  web[DbMigration]
2017.05.30 12:58:50 INFO  web[DbMigration] ==  MigrateUsersIdentity: migrating ===========================================
2017.05.30 12:58:50 INFO  web[o.s.d.v.MassUpdate] 661 users processed (11 items/sec)
2017.05.30 12:58:50 INFO  web[DbMigration] ==  MigrateUsersIdentity: migrated (0.1830s) ==================================
2017.05.30 12:58:50 INFO  web[DbMigration]
2017.05.30 12:58:50 INFO  web[DbMigration] ==  MigrateQualityGatesConditions: migrating ==================================
2017.05.30 12:58:50 INFO  web[o.s.d.v.MassUpdate] 0 quality gate conditions processed (0 items/sec)
2017.05.30 12:58:50 INFO  web[DbMigration] ==  MigrateQualityGatesConditions: migrated (0.0620s) =========================
2017.05.30 12:58:50 INFO  web[DbMigration]
2017.05.30 12:58:50 INFO  web[DbMigration] ==  MigrateDisabledUsersToOnlyKeepLoginAndName: migrating =====================
2017.05.30 12:58:50 INFO  web[o.s.d.v.MassUpdate] 0 users processed (0 items/sec)
2017.05.30 12:58:50 INFO  web[DbMigration] ==  MigrateDisabledUsersToOnlyKeepLoginAndName: migrated (0.0050s) ============
2017.05.30 12:58:50 INFO  web[DbMigration]
2017.05.30 12:58:50 INFO  web[DbMigration] ==  RemovePreviewPermission: migrating ========================================
2017.05.30 12:58:50 INFO  web[o.s.d.v.MassUpdate] 2 groups processed (0 items/sec)
2017.05.30 12:58:50 INFO  web[o.s.d.v.MassUpdate] 3 users processed (0 items/sec)
2017.05.30 12:58:50 INFO  web[DbMigration] ==  RemovePreviewPermission: migrated (0.0180s) ===============================
2017.05.30 12:58:50 INFO  web[DbMigration]
2017.05.30 12:58:50 INFO  web[DbMigration] ==  IncreaseProjectsNameColumnsSize: migrating ================================
2017.05.30 12:59:47 INFO  web[DbMigration] ==  IncreaseProjectsNameColumnsSize: migrated (56.4990s) ======================
2017.05.30 12:59:47 INFO  web[DbMigration]
2017.05.30 12:59:47 INFO  web[DbMigration] ==  AddRulesColumns: migrating ================================================
2017.05.30 12:59:48 INFO  web[DbMigration] ==  AddRulesColumns: migrated (0.9550s) =======================================
2017.05.30 12:59:48 INFO  web[DbMigration]
2017.05.30 12:59:48 INFO  web[DbMigration] ==  FeedRulesLongDateColumns: migrating =======================================
2017.05.30 12:59:50 INFO  web[o.s.d.v.MassUpdate] 10744 rules processed (179 items/sec)
2017.05.30 12:59:50 INFO  web[DbMigration] ==  FeedRulesLongDateColumns: migrated (2.4670s) ==============================
2017.05.30 12:59:50 INFO  web[DbMigration]
2017.05.30 12:59:50 INFO  web[DbMigration] ==  DeleteMeasuresWithCharacteristicId: migrating =============================
2017.05.30 13:00:50 INFO  web[o.s.d.v.MassUpdate] 290249 measures with characteristic processed (4837 items/sec)
2017.05.30 13:01:50 INFO  web[o.s.d.v.MassUpdate] 512749 measures with characteristic processed (3708 items/sec)
2017.05.30 13:02:30 INFO  web[o.s.d.v.MassUpdate] 660876 measures with characteristic processed (2468 items/sec)
2017.05.30 13:02:30 INFO  web[DbMigration] ==  DeleteMeasuresWithCharacteristicId: migrated (160.1720s) ==================
2017.05.30 13:02:30 INFO  web[DbMigration]
2017.05.30 13:02:30 INFO  web[DbMigration] ==  DropTableCharacteristics: migrating =======================================
2017.05.30 13:02:30 INFO  web[DbMigration] -- drop_table("characteristics")
2017.05.30 13:02:30 INFO  web[DbMigration]    -> 0.0270s
2017.05.30 13:02:30 INFO  web[DbMigration]    -> 0 rows
2017.05.30 13:02:30 INFO  web[DbMigration] ==  DropTableCharacteristics: migrated (0.0270s) ==============================
2017.05.30 13:02:30 INFO  web[DbMigration]
2017.05.30 13:02:30 INFO  web[DbMigration] ==  AddActiveRulesLongDateColumns: migrating ==================================
2017.05.30 13:02:31 INFO  web[DbMigration] ==  AddActiveRulesLongDateColumns: migrated (0.2530s) =========================
2017.05.30 13:02:31 INFO  web[DbMigration]
2017.05.30 13:02:31 INFO  web[DbMigration] ==  FeedActiveRulesLongDateColumns: migrating =================================
2017.05.30 13:02:32 INFO  web[o.s.d.v.MassUpdate] 9624 active rules processed (160 items/sec)
2017.05.30 13:02:32 INFO  web[DbMigration] ==  FeedActiveRulesLongDateColumns: migrated (1.5330s) ========================
2017.05.30 13:02:32 INFO  web[DbMigration]
2017.05.30 13:02:32 INFO  web[DbMigration] ==  AddIssuesType: migrating ==================================================
2017.05.30 13:35:40 INFO  web[DbMigration] ==  AddIssuesType: migrated (1987.7790s) ======================================
2017.05.30 13:35:40 INFO  web[DbMigration]
2017.05.30 13:35:40 INFO  web[DbMigration] ==  FeedIssuesTypes: migrating ================================================
2017.05.30 13:36:40 INFO  web[o.s.d.v.MassUpdate] 213249 issues processed (3554 items/sec)
2017.05.30 13:37:40 INFO  web[o.s.d.v.MassUpdate] 425999 issues processed (3545 items/sec)
2017.05.30 13:38:40 INFO  web[o.s.d.v.MassUpdate] 638249 issues processed (3537 items/sec)
2017.05.30 13:39:40 INFO  web[o.s.d.v.MassUpdate] 845749 issues processed (3458 items/sec)
2017.05.30 13:40:40 INFO  web[o.s.d.v.MassUpdate] 1054499 issues processed (3479 items/sec)
2017.05.30 13:41:40 INFO  web[o.s.d.v.MassUpdate] 1261999 issues processed (3458 items/sec)
2017.05.30 13:42:40 INFO  web[o.s.d.v.MassUpdate] 1470499 issues processed (3475 items/sec)
2017.05.30 13:43:40 INFO  web[o.s.d.v.MassUpdate] 1680249 issues processed (3495 items/sec)
2017.05.30 13:44:40 INFO  web[o.s.d.v.MassUpdate] 1887499 issues processed (3454 items/sec)
2017.05.30 13:45:40 INFO  web[o.s.d.v.MassUpdate] 2098057 issues processed (3509 items/sec)
2017.05.30 13:46:40 INFO  web[o.s.d.v.MassUpdate] 2306749 issues processed (3478 items/sec)
2017.05.30 13:47:40 INFO  web[o.s.d.v.MassUpdate] 2519499 issues processed (3545 items/sec)
2017.05.30 13:48:40 INFO  web[o.s.d.v.MassUpdate] 2737249 issues processed (3629 items/sec)
2017.05.30 13:49:40 INFO  web[o.s.d.v.MassUpdate] 2967249 issues processed (3833 items/sec)
2017.05.30 13:50:40 INFO  web[o.s.d.v.MassUpdate] 3198749 issues processed (3858 items/sec)
2017.05.30 13:51:40 INFO  web[o.s.d.v.MassUpdate] 3430499 issues processed (3862 items/sec)
2017.05.30 13:52:40 INFO  web[o.s.d.v.MassUpdate] 3662999 issues processed (3875 items/sec)
2017.05.30 13:53:40 INFO  web[o.s.d.v.MassUpdate] 3898999 issues processed (3933 items/sec)
2017.05.30 13:54:40 INFO  web[o.s.d.v.MassUpdate] 4133499 issues processed (3908 items/sec)
2017.05.30 13:55:40 INFO  web[o.s.d.v.MassUpdate] 4363249 issues processed (3829 items/sec)
2017.05.30 13:56:40 INFO  web[o.s.d.v.MassUpdate] 4599249 issues processed (3933 items/sec)
2017.05.30 13:57:40 INFO  web[o.s.d.v.MassUpdate] 4831499 issues processed (3870 items/sec)
2017.05.30 13:58:40 INFO  web[o.s.d.v.MassUpdate] 5062999 issues processed (3858 items/sec)
2017.05.30 13:59:40 INFO  web[o.s.d.v.MassUpdate] 5296999 issues processed (3900 items/sec)
2017.05.30 14:00:40 INFO  web[o.s.d.v.MassUpdate] 5529499 issues processed (3875 items/sec)
2017.05.30 14:01:40 INFO  web[o.s.d.v.MassUpdate] 5762499 issues processed (3883 items/sec)
2017.05.30 14:02:40 INFO  web[o.s.d.v.MassUpdate] 5994499 issues processed (3866 items/sec)
2017.05.30 14:03:40 INFO  web[o.s.d.v.MassUpdate] 6229249 issues processed (3912 items/sec)
2017.05.30 14:04:40 INFO  web[o.s.d.v.MassUpdate] 6459749 issues processed (3841 items/sec)
2017.05.30 14:05:40 INFO  web[o.s.d.v.MassUpdate] 6692499 issues processed (3879 items/sec)
2017.05.30 14:06:40 INFO  web[o.s.d.v.MassUpdate] 6924749 issues processed (3870 items/sec)
2017.05.30 14:07:40 INFO  web[o.s.d.v.MassUpdate] 7159249 issues processed (3908 items/sec)
2017.05.30 14:08:06 INFO  ce[o.s.c.a.WebServerWatcherImpl] Still waiting for WebServer...
2017.05.30 14:08:40 INFO  web[o.s.d.v.MassUpdate] 7395249 issues processed (3933 items/sec)
2017.05.30 14:09:40 INFO  web[o.s.d.v.MassUpdate] 7632749 issues processed (3958 items/sec)
2017.05.30 14:10:40 INFO  web[o.s.d.v.MassUpdate] 7861999 issues processed (3820 items/sec)
2017.05.30 14:11:40 INFO  web[o.s.d.v.MassUpdate] 8090499 issues processed (3808 items/sec)
2017.05.30 14:12:40 INFO  web[o.s.d.v.MassUpdate] 8314249 issues processed (3729 items/sec)
2017.05.30 14:13:07 INFO  web[o.s.d.v.MassUpdate] 8399255 issues processed (1416 items/sec)
2017.05.30 14:13:07 INFO  web[DbMigration] ==  FeedIssuesTypes: migrated (2246.8940s) ====================================
2017.05.30 14:13:07 INFO  web[DbMigration]
2017.05.30 14:13:07 INFO  web[DbMigration] ==  DropRulesDatesAndCharacteristics: migrating ===============================
2017.05.30 14:13:08 INFO  web[DbMigration] ==  DropRulesDatesAndCharacteristics: migrated (0.7330s) ======================
2017.05.30 14:13:08 INFO  web[DbMigration]
2017.05.30 14:13:08 INFO  web[DbMigration] ==  RenameRulesLongDates: migrating ===========================================
2017.05.30 14:13:08 INFO  web[DbMigration] -- rename_column("rules", "created_at_ms", "created_at")
2017.05.30 14:13:08 INFO  web[DbMigration]    -> 0.0360s
2017.05.30 14:13:08 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:08 INFO  web[DbMigration] -- rename_column("rules", "updated_at_ms", "updated_at")
2017.05.30 14:13:08 INFO  web[DbMigration]    -> 0.0130s
2017.05.30 14:13:08 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:08 INFO  web[DbMigration] ==  RenameRulesLongDates: migrated (0.0500s) ==================================
2017.05.30 14:13:08 INFO  web[DbMigration]
2017.05.30 14:13:08 INFO  web[DbMigration] ==  DropActiveRulesDateColumns: migrating =====================================
2017.05.30 14:13:08 INFO  web[DbMigration] ==  DropActiveRulesDateColumns: migrated (0.1830s) ============================
2017.05.30 14:13:08 INFO  web[DbMigration]
2017.05.30 14:13:08 INFO  web[DbMigration] ==  RenameActiveRulesLongDates: migrating =====================================
2017.05.30 14:13:08 INFO  web[DbMigration] -- rename_column("active_rules", "created_at_ms", "created_at")
2017.05.30 14:13:08 INFO  web[DbMigration]    -> 0.0110s
2017.05.30 14:13:08 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:08 INFO  web[DbMigration] -- rename_column("active_rules", "updated_at_ms", "updated_at")
2017.05.30 14:13:08 INFO  web[DbMigration]    -> 0.0150s
2017.05.30 14:13:08 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:08 INFO  web[DbMigration] ==  RenameActiveRulesLongDates: migrated (0.0260s) ============================
2017.05.30 14:13:08 INFO  web[DbMigration]
2017.05.30 14:13:08 INFO  web[DbMigration] ==  FeedRulesTypes: migrating =================================================
2017.05.30 14:13:11 INFO  web[o.s.d.v.MassUpdate] 10744 rules processed (179 items/sec)
2017.05.30 14:13:11 INFO  web[DbMigration] ==  FeedRulesTypes: migrated (2.8650s) ========================================
2017.05.30 14:13:11 INFO  web[DbMigration]
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RemoveDuplicationsPsidIndex: migrating ====================================
2017.05.30 14:13:11 INFO  web[DbMigration] -- remove_index(:duplications_index, {:name=>"duplications_index_psid"})
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0100s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RemoveDuplicationsPsidIndex: migrated (0.0100s) ===========================
2017.05.30 14:13:11 INFO  web[DbMigration]
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RemoveIssuesStatusIndex: migrating ========================================
2017.05.30 14:13:11 INFO  web[DbMigration] -- remove_index(:issues, {:name=>"issues_status"})
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0120s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RemoveIssuesStatusIndex: migrated (0.0130s) ===============================
2017.05.30 14:13:11 INFO  web[DbMigration]
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RemoveIssuesSeverityIndex: migrating ======================================
2017.05.30 14:13:11 INFO  web[DbMigration] -- remove_index(:issues, {:name=>"issues_severity"})
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0130s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RemoveIssuesSeverityIndex: migrated (0.0130s) =============================
2017.05.30 14:13:11 INFO  web[DbMigration]
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RenameIssuesDebtAndEffortToFixColumns: migrating ==========================
2017.05.30 14:13:11 INFO  web[DbMigration] -- rename_column("issues", "technical_debt", "effort")
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0190s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] -- rename_column("issues", "effort_to_fix", "gap")
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0130s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RenameIssuesDebtAndEffortToFixColumns: migrated (0.0320s) =================
2017.05.30 14:13:11 INFO  web[DbMigration]
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RenameRulesColumns: migrating =============================================
2017.05.30 14:13:11 INFO  web[DbMigration] -- rename_column("rules", "effort_to_fix_description", "gap_description")
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0120s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] -- rename_column("rules", "default_remediation_function", "def_remediation_function")
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0120s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] -- rename_column("rules", "remediation_coeff", "remediation_gap_mult")
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0110s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] -- rename_column("rules", "default_remediation_coeff", "def_remediation_gap_mult")
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0110s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] -- rename_column("rules", "remediation_offset", "remediation_base_effort")
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0120s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] -- rename_column("rules", "default_remediation_offset", "def_remediation_base_effort")
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0.0130s
2017.05.30 14:13:11 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:13:11 INFO  web[DbMigration] ==  RenameRulesColumns: migrated (0.0750s) ====================================
2017.05.30 14:13:11 INFO  web[DbMigration]
2017.05.30 14:13:11 INFO  web[DbMigration] ==  FixSizeOfIssueChangesLogin: migrating =====================================
2017.05.30 14:13:11 INFO  web[DbMigration] -- change_column(:issue_changes, :user_login, :string, {:limit=>255})
2017.05.30 14:15:32 INFO  web[DbMigration]    -> 140.5820s
2017.05.30 14:15:32 INFO  web[DbMigration]    -> 2552771 rows
2017.05.30 14:15:32 INFO  web[DbMigration] ==  FixSizeOfIssueChangesLogin: migrated (140.5830s) ==========================
2017.05.30 14:15:32 INFO  web[DbMigration]
2017.05.30 14:15:32 INFO  web[DbMigration] ==  AddUsersLocalColumn: migrating ============================================
2017.05.30 14:15:32 INFO  web[DbMigration] -- columns("users")
2017.05.30 14:15:32 INFO  web[DbMigration]    -> 0.0120s
2017.05.30 14:15:32 INFO  web[DbMigration] -- add_column("users", "user_local", :boolean, {})
2017.05.30 14:15:32 INFO  web[DbMigration]    -> 0.1570s
2017.05.30 14:15:32 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:15:32 INFO  web[DbMigration] ==  AddUsersLocalColumn: migrated (0.1710s) ===================================
2017.05.30 14:15:32 INFO  web[DbMigration]
2017.05.30 14:15:32 INFO  web[DbMigration] ==  DeleteMeasuresWithRuleId: migrating =======================================
2017.05.30 14:16:22 INFO  web[o.s.d.v.MassUpdate] 150991 measures with rule processed (2516 items/sec)
2017.05.30 14:16:22 INFO  web[DbMigration] ==  DeleteMeasuresWithRuleId: migrated (50.4570s) =============================
2017.05.30 14:16:22 INFO  web[DbMigration]
2017.05.30 14:16:22 INFO  web[DbMigration] ==  DropTableActionPlans: migrating ===========================================
2017.05.30 14:16:22 INFO  web[DbMigration] -- drop_table("action_plans")
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0.5150s
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:16:23 INFO  web[DbMigration] ==  DropTableActionPlans: migrated (0.5150s) ==================================
2017.05.30 14:16:23 INFO  web[DbMigration]
2017.05.30 14:16:23 INFO  web[DbMigration] ==  RemoveIssueActionPlanIndex: migrating =====================================
2017.05.30 14:16:23 INFO  web[DbMigration] -- remove_index(:issues, {:name=>"issues_action_plan_key"})
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0.0200s
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:16:23 INFO  web[DbMigration] ==  RemoveIssueActionPlanIndex: migrated (0.0200s) ============================
2017.05.30 14:16:23 INFO  web[DbMigration]
2017.05.30 14:16:23 INFO  web[DbMigration] ==  DeleteManualIssues: migrating =============================================
2017.05.30 14:16:23 INFO  web[o.s.d.v.MassUpdate] 0 manual issues processed (0 items/sec)
2017.05.30 14:16:23 INFO  web[DbMigration] ==  DeleteManualIssues: migrated (0.0040s) ====================================
2017.05.30 14:16:23 INFO  web[DbMigration]
2017.05.30 14:16:23 INFO  web[DbMigration] ==  DeleteManualRules: migrating ==============================================
2017.05.30 14:16:23 INFO  web[o.s.d.v.MassUpdate] 2 manual rules processed (0 items/sec)
2017.05.30 14:16:23 INFO  web[DbMigration] ==  DeleteManualRules: migrated (0.0050s) =====================================
2017.05.30 14:16:23 INFO  web[DbMigration]
2017.05.30 14:16:23 INFO  web[DbMigration] ==  AddIndexCeActivityIslastStatus: migrating =================================
2017.05.30 14:16:23 INFO  web[DbMigration] -- index_exists?(:ce_activity, ["is_last", "status"], {:name=>"ce_activity_islast_status"})
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0.0020s
2017.05.30 14:16:23 INFO  web[DbMigration] -- add_index(:ce_activity, ["is_last", "status"], {:name=>"ce_activity_islast_status"})
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0.0270s
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:16:23 INFO  web[DbMigration] ==  AddIndexCeActivityIslastStatus: migrated (0.0290s) ========================
2017.05.30 14:16:23 INFO  web[DbMigration]
2017.05.30 14:16:23 INFO  web[DbMigration] ==  FixTypeOfRuleTypeOnMysql: migrating =======================================
2017.05.30 14:16:23 INFO  web[DbMigration] ==  FixTypeOfRuleTypeOnMysql: migrated (0.0010s) ==============================
2017.05.30 14:16:23 INFO  web[DbMigration]
2017.05.30 14:16:23 INFO  web[DbMigration] ==  FixLengthOfIssuesMessageOnOracle: migrating ===============================
2017.05.30 14:16:23 INFO  web[DbMigration] ==  FixLengthOfIssuesMessageOnOracle: migrated (0.0010s) ======================
2017.05.30 14:16:23 INFO  web[DbMigration]
2017.05.30 14:16:23 INFO  web[DbMigration] ==  RemoveUselessIndexesOnGroupRoles: migrating ===============================
2017.05.30 14:16:23 INFO  web[DbMigration] -- remove_index(:group_roles, {:name=>"group_roles_group"})
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0.0260s
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:16:23 INFO  web[DbMigration] -- remove_index(:group_roles, {:name=>"group_roles_role"})
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0.0120s
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:16:23 INFO  web[DbMigration] ==  RemoveUselessIndexesOnGroupRoles: migrated (0.0400s) ======================
2017.05.30 14:16:23 INFO  web[DbMigration]
2017.05.30 14:16:23 INFO  web[DbMigration] ==  UpdateUsersExternalIdentityWhenEmpty: migrating ===========================
2017.05.30 14:16:23 INFO  web[o.s.d.v.MassUpdate] 0 users processed (0 items/sec)
2017.05.30 14:16:23 INFO  web[DbMigration] ==  UpdateUsersExternalIdentityWhenEmpty: migrated (0.0060s) ==================
2017.05.30 14:16:23 INFO  web[DbMigration]
2017.05.30 14:16:23 INFO  web[DbMigration] ==  AddIndexProjectMeasures: migrating ========================================
2017.05.30 14:16:23 INFO  web[DbMigration] -- index_exists?("project_measures", "project_id", {:name=>"tmp_measures_project_id"})
2017.05.30 14:16:23 INFO  web[DbMigration]    -> 0.0010s
2017.05.30 14:16:23 INFO  web[DbMigration] -- add_index("project_measures", "project_id", {:name=>"tmp_measures_project_id"})
2017.05.30 14:17:14 INFO  web[DbMigration]    -> 51.1250s
2017.05.30 14:17:14 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:17:14 INFO  web[DbMigration] ==  AddIndexProjectMeasures: migrated (51.1280s) ==============================
2017.05.30 14:17:14 INFO  web[DbMigration]
2017.05.30 14:17:14 INFO  web[DbMigration] ==  CleanUsurperRootComponents: migrating =====================================
2017.05.30 14:17:14 INFO  web[o.s.d.v.MassUpdate] 0 developers with incorrect project_uuid processed (0 items/sec)
2017.05.30 14:17:31 INFO  web[o.s.d.v.MassUpdate] 0 snapshots with inconsistent scope or qualifier processed (0 items/sec)
2017.05.30 14:17:41 INFO  web[o.s.d.v.MassUpdate] 0 usurper root components processed (0 items/sec)
2017.05.30 14:17:41 INFO  web[o.s.d.v.MassUpdate] 0 snapshots with incorrect root processed (0 items/sec)
2017.05.30 14:17:41 INFO  web[DbMigration] ==  CleanUsurperRootComponents: migrated (27.1670s) ===========================
2017.05.30 14:17:41 INFO  web[DbMigration]
2017.05.30 14:17:41 INFO  web[DbMigration] ==  DropIndexProjectMeasures: migrating =======================================
2017.05.30 14:17:41 INFO  web[DbMigration] -- remove_index("project_measures", {:name=>"tmp_measures_project_id"})
2017.05.30 14:17:41 INFO  web[DbMigration]    -> 0.0280s
2017.05.30 14:17:41 INFO  web[DbMigration]    -> 0 rows
2017.05.30 14:17:41 INFO  web[DbMigration] ==  DropIndexProjectMeasures: migrated (0.0280s) ==============================
2017.05.30 14:17:41 INFO  web[DbMigration]
2017.05.30 14:17:44 INFO  web[o.s.s.p.UpdateCenterClient] Update center: https://update.sonarsource.org/update-center.properties (no proxy)
2017.05.30 14:17:45 INFO  web[o.s.s.e.IndexCreator] Create index tests
2017.05.30 14:17:46 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [tests] creating index, cause [api], templates [], shards [5]/[0], mappings []
2017.05.30 14:17:47 INFO  web[o.s.s.e.IndexCreator] Create type tests/test
2017.05.30 14:17:47 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [tests] create_mapping [test]
2017.05.30 14:17:47 INFO  web[o.s.s.e.IndexCreator] Create index activities
2017.05.30 14:17:47 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [activities] creating index, cause [api], templates [], shards [5]/[0], mappings []
2017.05.30 14:17:47 INFO  web[o.s.s.e.IndexCreator] Create type activities/activity
2017.05.30 14:17:47 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [activities] create_mapping [activity]
2017.05.30 14:17:47 INFO  web[o.s.s.e.IndexCreator] Create index rules
2017.05.30 14:17:47 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [rules] creating index, cause [api], templates [], shards [5]/[0], mappings []
2017.05.30 14:17:48 INFO  web[o.s.s.e.IndexCreator] Create type rules/activeRule
2017.05.30 14:17:48 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [rules] create_mapping [activeRule]
2017.05.30 14:17:48 INFO  web[o.s.s.e.IndexCreator] Create type rules/rule
2017.05.30 14:17:48 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [rules] create_mapping [rule]
2017.05.30 14:17:48 INFO  web[o.s.s.e.IndexCreator] Create index issues
2017.05.30 14:17:48 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [issues] creating index, cause [api], templates [], shards [5]/[0], mappings []
2017.05.30 14:17:48 INFO  web[o.s.s.e.IndexCreator] Create type issues/authorization
2017.05.30 14:17:48 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [issues] create_mapping [authorization]
2017.05.30 14:17:48 INFO  web[o.s.s.e.IndexCreator] Create type issues/issue
2017.05.30 14:17:48 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [issues] create_mapping [issue]
2017.05.30 14:17:48 INFO  web[o.s.s.e.IndexCreator] Create index users
2017.05.30 14:17:48 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [users] creating index, cause [api], templates [], shards [5]/[0], mappings []
2017.05.30 14:17:48 INFO  web[o.s.s.e.IndexCreator] Create type users/user
2017.05.30 14:17:48 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [users] create_mapping [user]
2017.05.30 14:17:48 INFO  web[o.s.s.e.IndexCreator] Create index views
2017.05.30 14:17:48 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [views] creating index, cause [api], templates [], shards [5]/[0], mappings []
2017.05.30 14:17:48 INFO  web[o.s.s.e.IndexCreator] Create type views/view
2017.05.30 14:17:48 INFO   es[o.e.cluster.metadata]  [sonar-1496125357398] [views] create_mapping [view]
2017.05.30 14:17:48 INFO  web[org.sonar.INFO] Security realm: Crowd
2017.05.30 14:17:48 INFO  web[c.a.c.s.c.ClientPropertiesImpl] Loading property: 'application.name' : 'sonarqube'
2017.05.30 14:17:48 INFO  web[c.a.c.s.c.ClientPropertiesImpl] Failed to find value for property: application.login.url
2017.05.30 14:17:48 INFO  web[c.a.c.s.c.ClientPropertiesImpl] Loading property: 'session.tokenkey' : 'session.tokenkey'
2017.05.30 14:17:48 INFO  web[c.a.c.s.c.ClientPropertiesImpl] Loading property: 'session.lastvalidation' : 'session.lastvalidation'
2017.05.30 14:17:48 INFO  web[c.a.c.s.c.ClientPropertiesImpl] Loading property: 'session.validationinterval' : '1'
2017.05.30 14:17:48 INFO  web[c.a.c.s.c.ClientPropertiesImpl] Failed to find value for property: cookie.domain
2017.05.30 14:18:59 INFO  web[o.s.p.c.CrowdRealm] Crowd configuration is valid, connection test successful.
2017.05.30 14:18:59 INFO  web[org.sonar.INFO] Security realm started
2017.05.30 14:18:59 INFO  web[o.s.s.n.NotificationService] Notification service started (delay 60 sec.)
2017.05.30 14:18:59 INFO  web[o.s.d.c.MysqlCharsetHandler] Repair case-insensitive database columns
2017.05.30 14:18:59 INFO  web[o.s.s.s.RegisterMetrics] Register metrics
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Directory cycles [package_cycles]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Directory edges weight [package_edges_weight]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Suspect LCOM4 density [suspect_lcom4_density]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Directory tangle index [package_tangle_index]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric LCOM4 blocks [lcom4_blocks]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Total Useless Code [total-useless-lines]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Should Execute on Project [sonargraph_should_execute]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric File tangles [file_tangles]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Depth in Tree [dit]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Authors by line [authors_by_line]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric RFC [rfc]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric File dependencies to cut [package_tangles]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Number of Children [noc]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric duplication_lines_data [duplication_lines_data]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Class distribution /LCOM4 [lcom4_distribution]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Useless Duplicated Lines [useless-duplicated-lines]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric File tangle index [file_tangle_index]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric JIRA Issues [issues]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Internal Metric - Exclude Module [sonargraph_ignore_module]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric LCOM4 [lcom4]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Temp info on method lines [temp-method-lines]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Suspect file dependencies [file_feedback_edges]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Cycle Group Size [sonargraph_cycle_group_size]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric C/C++ ambiguous tokens [cpp-ambiguous-tokens]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric File cycles [file_cycles]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Last commit dates by line [last_commit_datetimes_by_line]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Revisions by line [revisions_by_line]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric C/C++ parsed tokens [cpp-parsed-tokens]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Class distribution /RFC [rfc_distribution]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Package dependencies to cut [package_feedback_edges]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric Dependency Matrix [dsm]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric C/C++ parse errors [cpp-parse-errors]
2017.05.30 14:19:00 INFO  web[o.s.s.s.RegisterMetrics] Disable metric File edges weight [file_edges_weight]
2017.05.30 14:19:00 INFO  web[o.s.s.r.RegisterRules] Register rules
2017.05.30 14:19:00 INFO  web[o.s.s.d.m.PlatformDatabaseMigration] DB migration failed | time=8675883ms
2017.05.30 14:19:00 ERROR web[o.s.s.d.m.PlatformDatabaseMigration] DB Migration or container restart failed. Process ended with an exception
org.sonar.api.utils.MessageException: The rule 'cppcheck:uninitVar' is invalid : Constant/issue functions must only have a non empty base effort


-Mohan

Julien Lancelot

unread,
May 30, 2017, 7:39:49 AM5/30/17
to moha...@gmail.com, SonarQube
Hi Mohan,

As you've already started a discussion 5 days ago on the GitHub issues of sonar-cxx (https://github.com/SonarOpenCommunity/sonar-cxx/issues/1149), I think it's not fair to start here a new thread without telling that this subject is already discussed elsewhere.

So please continue the discussion on the GitHub issues of sonar-cxx which seems to me to be the best place to discuss about this issue.

Regards,

--
You received this message because you are subscribed to the Google Groups "SonarQube" group.
To unsubscribe from this group and stop receiving emails from it, send an email to sonarqube+...@googlegroups.com.
To view this discussion on the web visit https://groups.google.com/d/msgid/sonarqube/b23fa374-2b24-43d7-ac17-45836d36a8b6%40googlegroups.com.
For more options, visit https://groups.google.com/d/optout.
--
Julien Lancelot | SonarSource

Mohan

unread,
May 30, 2017, 8:15:56 AM5/30/17
to Julien Lancelot, SonarQube
Ok i m sorry. Will follow-up over github support section.

Kindly delete this post.

-Mohan

To unsubscribe from this group and stop receiving emails from it, send an email to sonarqube+unsubscribe@googlegroups.com.
Reply all
Reply to author
Forward
0 new messages