After upgrade from 6.7.6 to 7.4, sonar doesn't start

sonarqube

(Serdar) #1

Must-share information (formatted with Markdown):

  • which versions are you using (SonarQube, Scanner, Plugin, and any relevant extension)
    • Sonarqube 7.4

    Plugins :

    • qualinsight-sonarqube-smell-plugin-4.0.0.jar
    • sonar-findbugs-plugin-3.9.1.jar
    • sonar-java-plugin-4.14.0.11784.jar
    • sonar-ldap-plugin-2.2.0.608.jar
    • sonar-motion-chart-plugin-1.7.jar
    • sonar-php-plugin-2.11.0.2485.jar
    • sonar-scm-git-plugin-1.2.jar
    • sonar-scm-svn-plugin-1.9.0.1295.jar
    • sonar-tab-metrics-plugin-1.4.1.jar
    • sonar-timeline-plugin-1.5.jar

jdbc-driver/oracle

  • ojdbc8-12.2.0.1.jar
  • what are you trying to achieve
    start sonarqube after upgrade from 6.7.6 to 7.4

  • what have you tried so far to achieve this

    • update all plugins
    • remove all plugins not necessary

The log from sonar.log and web.log

==> /usr/local/apps/sonar/logs/sonar.log <==
2018.12.05 14:48:46 INFO  app[][o.s.a.AppFileSystem] Cleaning or creating temp directory /usr/local/apps/sonar/sonarqube-7.4/temp
2018.12.05 14:48:46 INFO  app[][o.s.a.es.EsSettings] Elasticsearch listening on /127.0.0.1:9001
2018.12.05 14:48:46 INFO  app[][o.s.a.p.ProcessLauncherImpl] Launch process[[key='es', ipcIndex=1, logFilenamePrefix=es]] from [/usr/local/apps/sonar/sonarqube-7.4/elasticsearch]: /usr/local/apps/sonar/sonarqube-7.4/elasticsearch/bin/elasticsearch -Epath.conf=/usr/local/apps/sonar/sonarqube-7.4/temp/conf/es
2018.12.05 14:48:46 INFO  app[][o.s.a.SchedulerImpl] Waiting for Elasticsearch to be up and running
2018.12.05 14:48:46 INFO  app[][o.e.p.PluginsService] no modules loaded
2018.12.05 14:48:46 INFO  app[][o.e.p.PluginsService] loaded plugin [org.elasticsearch.transport.Netty4Plugin]
2018.12.05 14:48:54 INFO  app[][o.s.a.SchedulerImpl] Process[es] is up
2018.12.05 14:48:54 INFO  app[][o.s.a.p.ProcessLauncherImpl] Launch process[[key='web', ipcIndex=2, logFilenamePrefix=web]] from [/usr/local/apps/sonar/sonarqube-7.4]: /usr/local/apps/java/jdk1.8.0_162/jre/bin/java -Djava.awt.headless=true -Dfile.encoding=UTF-8 -Djava.io.tmpdir=/usr/local/apps/sonar/sonarqube-7.4/temp -Xmx512m -Xms128m -XX:+HeapDumpOnOutOfMemoryError -cp ./lib/common/*:/usr/local/apps/sonar/sonarqube-7.4/extensions/jdbc-driver/oracle/ojdbc8-12.2.0.1.jar org.sonar.server.app.WebServer /usr/local/apps/sonar/sonarqube-7.4/temp/sq-process985978715529056760properties

==> /usr/local/apps/sonar/logs/web.log <==
2018.12.05 14:48:54 INFO  web[][o.s.p.ProcessEntryPoint] Starting web
2018.12.05 14:48:54 INFO  web[][o.a.t.u.n.NioSelectorPool] Using a shared selector for servlet write/read
2018.12.05 14:48:55 INFO  web[][o.s.c.e.CoreExtensionsLoader] Loaded core extensions:
2018.12.05 14:48:55 INFO  web[][o.e.p.PluginsService] no modules loaded
2018.12.05 14:48:55 INFO  web[][o.e.p.PluginsService] loaded plugin [org.elasticsearch.join.ParentJoinPlugin]
2018.12.05 14:48:55 INFO  web[][o.e.p.PluginsService] loaded plugin [org.elasticsearch.percolator.PercolatorPlugin]
2018.12.05 14:48:55 INFO  web[][o.e.p.PluginsService] loaded plugin [org.elasticsearch.transport.Netty4Plugin]
2018.12.05 14:48:56 INFO  web[][o.s.s.e.EsClientProvider] Connected to local Elasticsearch: [127.0.0.1:9001]
2018.12.05 14:48:56 INFO  web[][o.s.s.p.LogServerVersion] SonarQube Server / 7.4.0.18908 / a4d0983e8057356b19996995343296311fbcc2ed
2018.12.05 14:48:56 INFO  web[][o.sonar.db.Database] Create JDBC data source for jdbc:oracle:thin:@//dbint_tech:1521/dbint_tech
2018.12.05 14:49:18 INFO  web[][o.s.s.p.ServerFileSystemImpl] SonarQube home: /usr/local/apps/sonar/sonarqube-7.4
2018.12.05 14:49:18 INFO  web[][o.s.s.u.SystemPasscodeImpl] System authentication by passcode is disabled
2018.12.05 14:49:18 INFO  web[][o.s.s.p.ServerPluginRepository] Deploy plugin LDAP / 2.2.0.608 / 79dc3fa4393a29667673c70182f3016288b548b7
2018.12.05 14:49:18 INFO  web[][o.s.s.p.w.MasterServletFilter] Initializing servlet filter org.sonar.server.ws.WebServiceFilter@3909d92a [pattern=UrlPattern{inclusions=[/api/system/migrate_db.*, ...], exclusions=[/api/properties*, ...]}]
2018.12.05 14:49:18 INFO  web[][o.s.s.a.EmbeddedTomcat] HTTP connector enabled on port 9000
2018.12.05 14:49:19 INFO  web[][o.s.s.p.UpdateCenterClient] Update center: https://update.sonarsource.org/update-center.properties (no proxy)
2018.12.05 14:49:20 INFO  web[][o.s.s.s.LogServerId] Server ID: 848B782B-AVvOz9nWNwjc42IGJq2e
2018.12.05 14:49:20 INFO  web[][org.sonar.INFO] Security realm: LDAP
2018.12.05 14:49:20 INFO  web[][o.s.p.l.LdapSettingsManager] User mapping: LdapUserMapping{baseDn=OU=Utilisateurs,DC=xxx,DC=xxx, request=(&(objectClass=user)(sAMAccountName={0})), realNameAttribute=cn, emailAttribute=mail}
2018.12.05 14:49:20 INFO  web[][o.s.p.l.LdapSettingsManager] Groups will not be synchronized, because property 'ldap.group.baseDn' is empty.
2018.12.05 14:49:20 INFO  web[][o.s.p.l.LdapContextFactory] Test LDAP connection on ldap://ldap1:389: OK
2018.12.05 14:49:20 INFO  web[][org.sonar.INFO] Security realm started
2018.12.05 14:49:20 WARN  web[][o.s.a.s.w.WebService$Action] The response example is not set on action api/plugins/download
2018.12.05 14:49:20 WARN  web[][o.s.a.s.w.WebService$Action] The response example is not set on action api/permissions/search_templates
2018.12.05 14:49:20 WARN  web[][o.s.a.s.w.WebService$Action] The response example is not set on action api/security_reports/show
2018.12.05 14:49:20 INFO  web[][o.s.s.t.TelemetryDaemon] Sharing of SonarQube statistics is enabled.
2018.12.05 14:49:20 INFO  web[][o.s.s.n.NotificationDaemon] Notification service started (delay 60 sec.)
2018.12.05 14:49:20 INFO  web[][o.s.s.s.GeneratePluginIndex] Generate scanner plugin index
2018.12.05 14:49:20 INFO  web[][o.s.s.s.RegisterPlugins] Register plugins
2018.12.05 14:49:20 INFO  web[][o.s.s.s.RegisterMetrics] Register metrics
2018.12.05 14:49:20 ERROR web[][o.s.s.p.Platform] Background initialization failed. Stopping SonarQube
org.apache.ibatis.exceptions.PersistenceException:
### Error updating database.  Cause: java.sql.SQLException: Invalid argument(s) in call
### SQL: INSERT INTO metrics (     name, description, direction, domain, short_name, qualitative, val_type, user_managed, enabled, worst_value,     best_value, optimized_best_value, hidden, delete_historical_data, decimal_scale)     VALUES (     ?, ?, ?,     ?, ?, ?,     ?, ?, ?,     ?, ?,     ?, ?, ?,     ?     )
### Cause: java.sql.SQLException: Invalid argument(s) in call
        at org.apache.ibatis.exceptions.ExceptionFactory.wrapException(ExceptionFactory.java:30)
        at org.apache.ibatis.session.defaults.DefaultSqlSession.update(DefaultSqlSession.java:200)
        at org.apache.ibatis.session.defaults.DefaultSqlSession.insert(DefaultSqlSession.java:185)
        at org.apache.ibatis.binding.MapperMethod.execute(MapperMethod.java:58)
        at org.apache.ibatis.binding.MapperProxy.invoke(MapperProxy.java:59)
        at com.sun.proxy.$Proxy26.insert(Unknown Source)
        at org.sonar.db.metric.MetricDao.insert(MetricDao.java:84)
        at org.sonar.server.startup.RegisterMetrics.save(RegisterMetrics.java:91)
        at org.sonar.server.startup.RegisterMetrics.register(RegisterMetrics.java:69)
        at org.sonar.server.startup.RegisterMetrics.start(RegisterMetrics.java:63)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at org.picocontainer.lifecycle.ReflectionLifecycleStrategy.invokeMethod(ReflectionLifecycleStrategy.java:110)
        at org.picocontainer.lifecycle.ReflectionLifecycleStrategy.start(ReflectionLifecycleStrategy.java:89)
        at org.picocontainer.injectors.AbstractInjectionFactory$LifecycleAdapter.start(AbstractInjectionFactory.java:84)
        at org.picocontainer.behaviors.AbstractBehavior.start(AbstractBehavior.java:169)
        at org.picocontainer.behaviors.Stored$RealComponentLifecycle.start(Stored.java:132)
        at org.picocontainer.behaviors.Stored.start(Stored.java:110)
        at org.picocontainer.DefaultPicoContainer.potentiallyStartAdapter(DefaultPicoContainer.java:1016)
        at org.picocontainer.DefaultPicoContainer.startAdapters(DefaultPicoContainer.java:1009)
        at org.picocontainer.DefaultPicoContainer.start(DefaultPicoContainer.java:767)
        at org.sonar.core.platform.ComponentContainer.startComponents(ComponentContainer.java:135)
        at org.sonar.server.platform.platformlevel.PlatformLevel.start(PlatformLevel.java:90)
        at org.sonar.server.platform.platformlevel.PlatformLevelStartup.access$001(PlatformLevelStartup.java:46)
        at org.sonar.server.platform.platformlevel.PlatformLevelStartup$1.doPrivileged(PlatformLevelStartup.java:82)
        at org.sonar.server.user.DoPrivileged.execute(DoPrivileged.java:46)
        at org.sonar.server.platform.platformlevel.PlatformLevelStartup.start(PlatformLevelStartup.java:79)
        at org.sonar.server.platform.Platform.executeStartupTasks(Platform.java:196)
        at org.sonar.server.platform.Platform.access$400(Platform.java:46)
        at org.sonar.server.platform.Platform$1.lambda$doRun$1(Platform.java:121)
        at org.sonar.server.platform.Platform$AutoStarterRunnable.runIfNotAborted(Platform.java:371)
        at org.sonar.server.platform.Platform$1.doRun(Platform.java:121)
        at org.sonar.server.platform.Platform$AutoStarterRunnable.run(Platform.java:355)
        at java.lang.Thread.run(Thread.java:748)
Caused by: java.sql.SQLException: Invalid argument(s) in call
        at oracle.jdbc.driver.AutoKeyInfo.getNewSql(AutoKeyInfo.java:187)
        at oracle.jdbc.driver.PhysicalConnection.prepareStatement(PhysicalConnection.java:4342)
        at org.apache.commons.dbcp2.DelegatingConnection.prepareStatement(DelegatingConnection.java:771)
        at org.apache.commons.dbcp2.DelegatingConnection.prepareStatement(DelegatingConnection.java:771)
        at org.apache.ibatis.executor.statement.PreparedStatementHandler.instantiateStatement(PreparedStatementHandler.java:82)
        at org.apache.ibatis.executor.statement.BaseStatementHandler.prepare(BaseStatementHandler.java:88)
        at org.apache.ibatis.executor.statement.RoutingStatementHandler.prepare(RoutingStatementHandler.java:59)
        at org.apache.ibatis.executor.ReuseExecutor.prepareStatement(ReuseExecutor.java:89)
        at org.apache.ibatis.executor.ReuseExecutor.doUpdate(ReuseExecutor.java:51)
        at org.apache.ibatis.executor.BaseExecutor.update(BaseExecutor.java:117)
        at org.apache.ibatis.executor.CachingExecutor.update(CachingExecutor.java:76)
        at org.apache.ibatis.session.defaults.DefaultSqlSession.update(DefaultSqlSession.java:198)
        ... 34 common frames omitted
2018.12.05 14:49:21 INFO  web[][o.s.p.StopWatcher] Stopping process

==> /usr/local/apps/sonar/logs/sonar.log <==
2018.12.05 14:49:24 INFO  app[][o.s.a.SchedulerImpl] Process [web] is stopped
2018.12.05 14:49:24 INFO  app[][o.s.a.SchedulerImpl] Process [es] is stopped
2018.12.05 14:49:24 WARN  app[][o.s.a.p.AbstractProcessMonitor] Process exited with exit value [es]: 143
2018.12.05 14:49:24 INFO  app[][o.s.a.SchedulerImpl] SonarQube is stopped
<-- Wrapper Stopped

I had the same problem after upgrade from 6.5 to 6.7.6.
The problem was plugins. I go back to old versions from some plugins and that resolve problem. But nothings works with the version 7.4.

Can you help me please ?

Regards,
Serdar


(G Ann Campbell) #2

Hi Serdar,

You mentioned plugins, so let’s start with that.

  • sonar-java-plugin-4.14.0.11784.jar - the current version is 5.9.2, and to be running a version as old as 4.14, you have to have replaced the newer version that was shipped with 7.4.
  • sonar-motion-chart-plugin-1.7.jar - This is useless since SQ 6.2, in which dashboards were removed
  • sonar-php-plugin-2.11.0.2485.jar - Current version is 2.15
  • sonar-scm-git-plugin-1.2.jar - Current version 1.4.1
  • sonar-tab-metrics-plugin-1.4.1.jar - Deprecated in April 2015 with the release of SQ 5.1
  • sonar-timeline-plugin-1.5.jar - Useless since the release of SQ 6.2

Moving on from that, it’s a shame we don’t have the parameter values for that query. Could you address the plugins I’ve cited, and try again with TRACE logging? Note that you’ll want to turn your log level back down as soon as we get this straightened out.

 
Ann


(Serdar) #3

Thank you Ann,

My sonar.properties :

sonar.jdbc.username=xxx
sonar.jdbc.password=xxx
sonar.jdbc.url=jdbc:oracle:thin:@//xxxx
sonar.jdbc.maxActive=60
sonar.jdbc.maxIdle=5
sonar.jdbc.minIdle=2
sonar.jdbc.maxWait=5000
sonar.jdbc.minEvictableIdleTimeMillis=600000
sonar.jdbc.timeBetweenEvictionRunsMillis=30000
sonar.security.realm=LDAP
ldap.url=ldap://xxx:389
ldap.user.baseDn=OU=Utilisateurs,DC=xxx,DC=xxx
ldap.user.request=(&(objectClass=user)(sAMAccountName={login}))
ldap.bindDn=usr_sonar
ldap.bindPassword=xxx
ldap.authentication=simple
ldap.realm=xxx
sonar.web.javaOpts=-Xmx512m -Xms128m -XX:+HeapDumpOnOutOfMemoryError
sonar.ce.javaOpts=-Xmx512m -Xms128m -XX:+HeapDumpOnOutOfMemoryError
sonar.search.javaOpts=-Xms512m \
 -Xmx512m \
 -XX:+HeapDumpOnOutOfMemoryError
sonar.log.level=STRACE
sonar.log.level.app=STRACE
sonar.log.level.web=STRACE
sonar.log.level.ce=STRACE
sonar.log.level.es=STRACE

my wrapper.conf :

wrapper.java.command=/usr/local/apps/java/jdk1.8.0_162/bin/java
wrapper.java.additional.1=-Dsonar.wrapped=true
wrapper.java.additional.2=-Djava.awt.headless=true
wrapper.java.mainclass=org.tanukisoftware.wrapper.WrapperSimpleApp
wrapper.java.classpath.1=../../lib/jsw/*.jar
wrapper.java.classpath.2=../../lib/common/*.jar
wrapper.java.classpath.3=../../lib/*.jar
wrapper.java.library.path.1=./lib
wrapper.app.parameter.1=org.sonar.application.App
wrapper.java.initmemory=8
wrapper.java.maxmemory=32
wrapper.console.format=PM
wrapper.console.loglevel=INFO
wrapper.logfile=../../logs/sonar.log
wrapper.logfile.format=M
wrapper.logfile.loglevel=INFO
wrapper.syslog.loglevel=NONE
wrapper.console.title=SonarQube
wrapper.single_invocation=true
wrapper.ntservice.name=SonarQube
wrapper.ntservice.displayname=SonarQube
wrapper.ntservice.description=SonarQube
wrapper.ntservice.dependency.1=
wrapper.ntservice.starttype=AUTO_START
wrapper.ntservice.interactive=false
wrapper.disable_restarts=TRUE
wrapper.ping.timeout=0
wrapper.shutdown.timeout=3000
wrapper.jvm_exit.timeout=3000

my plugins :

  • qualinsight-sonarqube-smell-plugin-4.0.0.jar
  • sonar-findbugs-plugin-3.9.1.jar
  • sonar-java-plugin-5.9.2.16552.jar
  • sonar-ldap-plugin-2.2.0.608.jar
  • sonar-php-plugin-2.15.0.4060.jar
  • sonar-scm-git-plugin-1.4.1.1128.jar
  • sonar-scm-svn-plugin-1.9.0.1295.jar

Still same message :

==> /usr/local/apps/sonar/logs/es.log <==
2018.12.05 15:48:13 WARN  es[][o.e.b.JNANatives] unable to install syscall filter:
java.lang.UnsupportedOperationException: seccomp unavailable: CONFIG_SECCOMP not compiled into kernel, CONFIG_SECCOMP and CONFIG_SECCOMP_FILTER are needed
        at org.elasticsearch.bootstrap.SystemCallFilter.linuxImpl(SystemCallFilter.java:364) ~[elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.SystemCallFilter.init(SystemCallFilter.java:639) ~[elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.JNANatives.tryInstallSystemCallFilter(JNANatives.java:258) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.Natives.tryInstallSystemCallFilter(Natives.java:113) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.Bootstrap.initializeNatives(Bootstrap.java:111) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.Bootstrap.setup(Bootstrap.java:195) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.Bootstrap.init(Bootstrap.java:342) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.Elasticsearch.init(Elasticsearch.java:132) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.Elasticsearch.execute(Elasticsearch.java:123) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.cli.EnvironmentAwareCommand.execute(EnvironmentAwareCommand.java:70) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.cli.Command.mainWithoutErrorHandling(Command.java:134) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.cli.Command.main(Command.java:90) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.Elasticsearch.main(Elasticsearch.java:91) [elasticsearch-5.6.3.jar:5.6.3]
        at org.elasticsearch.bootstrap.Elasticsearch.main(Elasticsearch.java:84) [elasticsearch-5.6.3.jar:5.6.3]
2018.12.05 15:48:14 INFO  es[][o.e.n.Node] initializing ...
2018.12.05 15:48:14 INFO  es[][o.e.e.NodeEnvironment] using [1] data paths, mounts [[/usr/local/apps (/dev/mapper/vg_app-LogVol_APP)]], net usable_space [3.4gb], net total_space [8.9gb], spins? [possibly], types [ext4]
2018.12.05 15:48:14 INFO  es[][o.e.e.NodeEnvironment] heap size [494.9mb], compressed ordinary object pointers [true]
2018.12.05 15:48:14 INFO  es[][o.e.n.Node] node name [sonarqube], node ID [rmc6Lkk6S_iv6af_VUDHbA]
2018.12.05 15:48:14 INFO  es[][o.e.n.Node] version[5.6.3], pid[12591], build[1a2f265/2017-10-06T20:33:39.012Z], OS[Linux/2.6.32-696.23.1.el6.x86_64/amd64], JVM[Oracle Corporation/Java HotSpot(TM) 64-Bit Server VM/1.8.0_162/25.162-b12]
2018.12.05 15:48:14 INFO  es[][o.e.n.Node] JVM arguments [-XX:+UseConcMarkSweepGC, -XX:CMSInitiatingOccupancyFraction=75, -XX:+UseCMSInitiatingOccupancyOnly, -XX:+AlwaysPreTouch, -Xss1m, -Djava.awt.headless=true, -Dfile.encoding=UTF-8, -Djna.nosys=true, -Djdk.io.permissionsUseCanonicalPath=true, -Dio.netty.noUnsafe=true, -Dio.netty.noKeySetOptimization=true, -Dio.netty.recycler.maxCapacityPerThread=0, -Dlog4j.shutdownHookEnabled=false, -Dlog4j2.disable.jmx=true, -Dlog4j.skipJansi=true, -Xms512m, -Xmx512m, -XX:+HeapDumpOnOutOfMemoryError, -Des.path.home=/usr/local/apps/sonar/sonarqube-7.4/elasticsearch]
2018.12.05 15:48:14 INFO  es[][o.e.p.PluginsService] loaded module [aggs-matrix-stats]
2018.12.05 15:48:14 INFO  es[][o.e.p.PluginsService] loaded module [ingest-common]
2018.12.05 15:48:14 INFO  es[][o.e.p.PluginsService] loaded module [parent-join]
2018.12.05 15:48:14 INFO  es[][o.e.p.PluginsService] loaded module [percolator]
2018.12.05 15:48:14 INFO  es[][o.e.p.PluginsService] loaded module [reindex]
2018.12.05 15:48:14 INFO  es[][o.e.p.PluginsService] loaded module [transport-netty4]
2018.12.05 15:48:14 INFO  es[][o.e.p.PluginsService] no plugins loaded
2018.12.05 15:48:15 INFO  es[][o.e.d.DiscoveryModule] using discovery type [zen]
2018.12.05 15:48:16 INFO  es[][o.e.n.Node] initialized
2018.12.05 15:48:16 INFO  es[][o.e.n.Node] starting ...
2018.12.05 15:48:16 INFO  es[][o.e.t.TransportService] publish_address {127.0.0.1:9001}, bound_addresses {127.0.0.1:9001}
2018.12.05 15:48:16 WARN  es[][o.e.b.BootstrapChecks] max file descriptors [4096] for elasticsearch process is too low, increase to at least [65536]
2018.12.05 15:48:16 WARN  es[][o.e.b.BootstrapChecks] max number of threads [1024] for user [usr_sonar] is too low, increase to at least [2048]
2018.12.05 15:48:16 WARN  es[][o.e.b.BootstrapChecks] system call filters failed to install; check the logs and fix your configuration or disable system call filters at your own risk
2018.12.05 15:48:19 INFO  es[][o.e.c.s.ClusterService] new_master {sonarqube}{rmc6Lkk6S_iv6af_VUDHbA}{0xiSXxrSS7WVYh5yMlmPdQ}{127.0.0.1}{127.0.0.1:9001}{rack_id=sonarqube}, reason: zen-disco-elected-as-master ([0] nodes joined)
2018.12.05 15:48:19 INFO  es[][o.e.n.Node] started
2018.12.05 15:48:20 INFO  es[][o.e.g.GatewayService] recovered [8] indices into cluster_state
2018.12.05 15:48:20 INFO  es[][o.e.c.r.a.AllocationService] Cluster health status changed from [RED] to [GREEN] (reason: [shards started [[metadatas][0]] ...]).

==> /usr/local/apps/sonar/logs/sonar.log <==
2018.12.05 15:48:20 INFO  app[][o.s.a.SchedulerImpl] Process[es] is up
2018.12.05 15:48:20 INFO  app[][o.s.a.p.ProcessLauncherImpl] Launch process[[key='web', ipcIndex=2, logFilenamePrefix=web]] from [/usr/local/apps/sonar/sonarqube-7.4]: /usr/local/apps/java/jdk1.8.0_162/jre/bin/java -Djava.awt.headless=true -Dfile.encoding=UTF-8 -Djava.io.tmpdir=/usr/local/apps/sonar/sonarqube-7.4/temp -Xmx512m -Xms128m -XX:+HeapDumpOnOutOfMemoryError -cp ./lib/common/*:/usr/local/apps/sonar/sonarqube-7.4/extensions/jdbc-driver/oracle/ojdbc8-12.2.0.1.jar org.sonar.server.app.WebServer /usr/local/apps/sonar/sonarqube-7.4/temp/sq-process7116479514706467217properties

==> /usr/local/apps/sonar/logs/web.log <==
2018.12.05 15:48:21 INFO  web[][o.s.p.ProcessEntryPoint] Starting web
2018.12.05 15:48:21 INFO  web[][o.a.t.u.n.NioSelectorPool] Using a shared selector for servlet write/read
2018.12.05 15:48:22 INFO  web[][o.s.c.e.CoreExtensionsLoader] Loaded core extensions:
2018.12.05 15:48:22 INFO  web[][o.e.p.PluginsService] no modules loaded
2018.12.05 15:48:22 INFO  web[][o.e.p.PluginsService] loaded plugin [org.elasticsearch.join.ParentJoinPlugin]
2018.12.05 15:48:22 INFO  web[][o.e.p.PluginsService] loaded plugin [org.elasticsearch.percolator.PercolatorPlugin]
2018.12.05 15:48:22 INFO  web[][o.e.p.PluginsService] loaded plugin [org.elasticsearch.transport.Netty4Plugin]
2018.12.05 15:48:23 INFO  web[][o.s.s.e.EsClientProvider] Connected to local Elasticsearch: [127.0.0.1:9001]
2018.12.05 15:48:23 INFO  web[][o.s.s.p.LogServerVersion] SonarQube Server / 7.4.0.18908 / a4d0983e8057356b19996995343296311fbcc2ed
2018.12.05 15:48:23 INFO  web[][o.sonar.db.Database] Create JDBC data source for jdbc:oracle:thin:@//dbint_tech:1521/dbint_tech
2018.12.05 15:48:47 INFO  web[][o.s.s.p.ServerFileSystemImpl] SonarQube home: /usr/local/apps/sonar/sonarqube-7.4
2018.12.05 15:48:47 INFO  web[][o.s.s.u.SystemPasscodeImpl] System authentication by passcode is disabled
2018.12.05 15:48:48 INFO  web[][o.s.s.p.ServerPluginRepository] Deploy plugin Code Smells / 4.0.0
2018.12.05 15:48:48 INFO  web[][o.s.s.p.ServerPluginRepository] Deploy plugin Findbugs / 3.9.1 /
2018.12.05 15:48:48 INFO  web[][o.s.s.p.ServerPluginRepository] Deploy plugin Git / 1.4.1.1128 / e051f5aeb379541b13956447b5dc8b4e0b23b098
2018.12.05 15:48:48 INFO  web[][o.s.s.p.ServerPluginRepository] Deploy plugin LDAP / 2.2.0.608 / 79dc3fa4393a29667673c70182f3016288b548b7
2018.12.05 15:48:48 INFO  web[][o.s.s.p.ServerPluginRepository] Deploy plugin SonarJava / 5.9.2.16552 / 293a758c27e64839893f15a684a13bcd769e26b8
2018.12.05 15:48:48 INFO  web[][o.s.s.p.ServerPluginRepository] Deploy plugin SonarPHP / 2.15.0.4060 / 307e5583b6d098c7bc13a22b7738e76a13c74e5d
2018.12.05 15:48:48 INFO  web[][o.s.s.p.ServerPluginRepository] Deploy plugin Svn / 1.9.0.1295 / 942e075773975354e32691a60bfd968065703e04
2018.12.05 15:48:48 INFO  web[][o.s.s.p.w.MasterServletFilter] Initializing servlet filter org.sonar.server.ws.WebServiceFilter@6972677 [pattern=UrlPattern{inclusions=[/api/system/migrate_db.*, ...], exclusions=[/api/properties*, ...]}]
2018.12.05 15:48:48 INFO  web[][o.s.s.a.EmbeddedTomcat] HTTP connector enabled on port 9000
2018.12.05 15:48:49 INFO  web[][o.s.s.p.UpdateCenterClient] Update center: https://update.sonarsource.org/update-center.properties (no proxy)
2018.12.05 15:48:50 INFO  web[][o.s.s.s.LogServerId] Server ID: 848B782B-AVvOz9nWNwjc42IGJq2e
2018.12.05 15:48:50 INFO  web[][org.sonar.INFO] Security realm: LDAP
2018.12.05 15:48:50 INFO  web[][o.s.p.l.LdapSettingsManager] User mapping: LdapUserMapping{baseDn=OU=Utilisateurs,DC=xxx,DC=xxx, request=(&(objectClass=user)(sAMAccountName={0})), realNameAttribute=cn, emailAttribute=mail}
2018.12.05 15:48:50 INFO  web[][o.s.p.l.LdapSettingsManager] Groups will not be synchronized, because property 'ldap.group.baseDn' is empty.
2018.12.05 15:48:50 INFO  web[][o.s.p.l.LdapContextFactory] Test LDAP connection on ldap://xxx:389: OK
2018.12.05 15:48:50 INFO  web[][org.sonar.INFO] Security realm started
2018.12.05 15:48:50 WARN  web[][o.s.a.s.w.WebService$Action] The response example is not set on action api/plugins/download
2018.12.05 15:48:50 WARN  web[][o.s.a.s.w.WebService$Action] The response example is not set on action api/permissions/search_templates
2018.12.05 15:48:50 WARN  web[][o.s.a.s.w.WebService$Action] The response example is not set on action api/security_reports/show
2018.12.05 15:48:50 INFO  web[][o.s.s.t.TelemetryDaemon] Sharing of SonarQube statistics is enabled.
2018.12.05 15:48:50 INFO  web[][o.s.s.n.NotificationDaemon] Notification service started (delay 60 sec.)
2018.12.05 15:48:50 INFO  web[][o.s.s.s.GeneratePluginIndex] Generate scanner plugin index
2018.12.05 15:48:50 INFO  web[][o.s.s.s.RegisterPlugins] Register plugins
2018.12.05 15:48:50 INFO  web[][o.s.s.s.RegisterMetrics] Register metrics
2018.12.05 15:48:50 ERROR web[][o.s.s.p.Platform] Background initialization failed. Stopping SonarQube
org.apache.ibatis.exceptions.PersistenceException:
### Error updating database.  Cause: java.sql.SQLException: Invalid argument(s) in call
### SQL: INSERT INTO metrics (     name, description, direction, domain, short_name, qualitative, val_type, user_managed, enabled, worst_value,     best_value, optimized_best_value, hidden, delete_historical_data, decimal_scale)     VALUES (     ?, ?, ?,     ?, ?, ?,     ?, ?, ?,     ?, ?,     ?, ?, ?,     ?     )
### Cause: java.sql.SQLException: Invalid argument(s) in call
        at org.apache.ibatis.exceptions.ExceptionFactory.wrapException(ExceptionFactory.java:30)
        at org.apache.ibatis.session.defaults.DefaultSqlSession.update(DefaultSqlSession.java:200)
        at org.apache.ibatis.session.defaults.DefaultSqlSession.insert(DefaultSqlSession.java:185)
        at org.apache.ibatis.binding.MapperMethod.execute(MapperMethod.java:58)
        at org.apache.ibatis.binding.MapperProxy.invoke(MapperProxy.java:59)
        at com.sun.proxy.$Proxy30.insert(Unknown Source)
        at org.sonar.db.metric.MetricDao.insert(MetricDao.java:84)
        at org.sonar.server.startup.RegisterMetrics.save(RegisterMetrics.java:91)
        at org.sonar.server.startup.RegisterMetrics.register(RegisterMetrics.java:69)
        at org.sonar.server.startup.RegisterMetrics.start(RegisterMetrics.java:63)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at org.picocontainer.lifecycle.ReflectionLifecycleStrategy.invokeMethod(ReflectionLifecycleStrategy.java:110)
        at org.picocontainer.lifecycle.ReflectionLifecycleStrategy.start(ReflectionLifecycleStrategy.java:89)
        at org.picocontainer.injectors.AbstractInjectionFactory$LifecycleAdapter.start(AbstractInjectionFactory.java:84)
        at org.picocontainer.behaviors.AbstractBehavior.start(AbstractBehavior.java:169)
        at org.picocontainer.behaviors.Stored$RealComponentLifecycle.start(Stored.java:132)
        at org.picocontainer.behaviors.Stored.start(Stored.java:110)
        at org.picocontainer.DefaultPicoContainer.potentiallyStartAdapter(DefaultPicoContainer.java:1016)
        at org.picocontainer.DefaultPicoContainer.startAdapters(DefaultPicoContainer.java:1009)
        at org.picocontainer.DefaultPicoContainer.start(DefaultPicoContainer.java:767)
        at org.sonar.core.platform.ComponentContainer.startComponents(ComponentContainer.java:135)
        at org.sonar.server.platform.platformlevel.PlatformLevel.start(PlatformLevel.java:90)
        at org.sonar.server.platform.platformlevel.PlatformLevelStartup.access$001(PlatformLevelStartup.java:46)
        at org.sonar.server.platform.platformlevel.PlatformLevelStartup$1.doPrivileged(PlatformLevelStartup.java:82)
        at org.sonar.server.user.DoPrivileged.execute(DoPrivileged.java:46)
        at org.sonar.server.platform.platformlevel.PlatformLevelStartup.start(PlatformLevelStartup.java:79)
        at org.sonar.server.platform.Platform.executeStartupTasks(Platform.java:196)
        at org.sonar.server.platform.Platform.access$400(Platform.java:46)
        at org.sonar.server.platform.Platform$1.lambda$doRun$1(Platform.java:121)
        at org.sonar.server.platform.Platform$AutoStarterRunnable.runIfNotAborted(Platform.java:371)
        at org.sonar.server.platform.Platform$1.doRun(Platform.java:121)
        at org.sonar.server.platform.Platform$AutoStarterRunnable.run(Platform.java:355)
        at java.lang.Thread.run(Thread.java:748)
Caused by: java.sql.SQLException: Invalid argument(s) in call
        at oracle.jdbc.driver.AutoKeyInfo.getNewSql(AutoKeyInfo.java:187)
        at oracle.jdbc.driver.PhysicalConnection.prepareStatement(PhysicalConnection.java:4342)
        at org.apache.commons.dbcp2.DelegatingConnection.prepareStatement(DelegatingConnection.java:771)
        at org.apache.commons.dbcp2.DelegatingConnection.prepareStatement(DelegatingConnection.java:771)
        at org.apache.ibatis.executor.statement.PreparedStatementHandler.instantiateStatement(PreparedStatementHandler.java:82)
        at org.apache.ibatis.executor.statement.BaseStatementHandler.prepare(BaseStatementHandler.java:88)
        at org.apache.ibatis.executor.statement.RoutingStatementHandler.prepare(RoutingStatementHandler.java:59)
        at org.apache.ibatis.executor.ReuseExecutor.prepareStatement(ReuseExecutor.java:89)
        at org.apache.ibatis.executor.ReuseExecutor.doUpdate(ReuseExecutor.java:51)
        at org.apache.ibatis.executor.BaseExecutor.update(BaseExecutor.java:117)
        at org.apache.ibatis.executor.CachingExecutor.update(CachingExecutor.java:76)
        at org.apache.ibatis.session.defaults.DefaultSqlSession.update(DefaultSqlSession.java:198)
        ... 34 common frames omitted
2018.12.05 15:48:51 INFO  web[][o.s.p.StopWatcher] Stopping process

==> /usr/local/apps/sonar/logs/es.log <==
2018.12.05 15:48:53 INFO  es[][o.e.n.Node] stopping ...
2018.12.05 15:48:53 INFO  es[][o.e.n.Node] stopped
2018.12.05 15:48:53 INFO  es[][o.e.n.Node] closing ...

==> /usr/local/apps/sonar/logs/sonar.log <==
2018.12.05 15:48:53 INFO  app[][o.s.a.SchedulerImpl] Process [web] is stopped

==> /usr/local/apps/sonar/logs/es.log <==
2018.12.05 15:48:53 INFO  es[][o.e.n.Node] closed

==> /usr/local/apps/sonar/logs/sonar.log <==
2018.12.05 15:48:53 INFO  app[][o.s.a.SchedulerImpl] Process [es] is stopped
2018.12.05 15:48:53 WARN  app[][o.s.a.p.AbstractProcessMonitor] Process exited with exit value [es]: 143
2018.12.05 15:48:53 INFO  app[][o.s.a.SchedulerImpl] SonarQube is stopped
<-- Wrapper Stopped

(G Ann Campbell) #4

Hi,

I don’t think STRACE is a recognized logging level, so it’s probably defaulting back to INFO. But that’s okay; you’re not actually getting the same error. This is a different error in a different log. And in fact, it’s not an error at all; it’s a warning.

So… are you still down? Or are there errors in other logs?

 
Ann


(Serdar) #5

Sorry I mad a mistake with TRACE log :

Now the good one :

2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=blocker_violations, Blocker Issues, INT, true, Issues, Blocker issues, -1, false, true, 4, 10043
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=critical_violations, Critical Issues, INT, true, Issues, Critical issues, -1, false, true, 4, 10044
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=major_violations, Major Issues, INT, true, Issues, Major issues, -1, false, true, 4, 10045
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=minor_violations, Minor Issues, INT, true, Issues, Minor issues, -1, false, true, 4, 10046
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=info_violations, Info Issues, INT, true, Issues, Info issues, -1, false, true, 4, 10047
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_violations, New Issues, INT, true, Issues, New issues, -1, false, true, 4, 10116
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_blocker_violations, New Blocker Issues, INT, true, Issues, New Blocker issues, -1, false, true, 4, 10117
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_critical_violations, New Critical Issues, INT, true, Issues, New Critical issues, -1, false, true, 4, 10118
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_major_violations, New Major Issues, INT, true, Issues, New Major issues, -1, false, true, 4, 10119
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_minor_violations, New Minor Issues, INT, true, Issues, New Minor issues, -1, false, true, 4, 10120
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_info_violations, New Info Issues, INT, true, Issues, New Info issues, -1, false, true, 4, 10121
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=false_positive_issues, False Positive Issues, INT, true, Issues, False positive issues, -1, false, false, 4, 10302
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=wont_fix_issues, Won't Fix Issues, INT, true, Issues, Won't fix issues, -1, false, false, 4, 10360
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=open_issues, Open Issues, INT, true, Issues, Open issues, -1, false, false, 4, 10303
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=reopened_issues, Reopened Issues, INT, true, Issues, Reopened issues, -1, false, true, 4, 10304
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=confirmed_issues, Confirmed Issues, INT, true, Issues, Confirmed issues, -1, false, true, 4, 10305
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=code_smells, Code Smells, INT, true, Maintainability, Code Smells, -1, false, false, 4, 10361
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_code_smells, New Code Smells, INT, true, Maintainability, New Code Smells, -1, false, true, 4, 10362
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=bugs, Bugs, INT, true, Reliability, Bugs, -1, false, false, 4, 10363
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_bugs, New Bugs, INT, true, Reliability, New Bugs, -1, false, true, 4, 10364
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=vulnerabilities, Vulnerabilities, INT, true, Security, Vulnerabilities, -1, false, false, 4, 10365
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_vulnerabilities, New Vulnerabilities, INT, true, Security, New Vulnerabilities, -1, false, true, 4, 10366
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=sqale_index, Technical Debt, WORK_DUR, true, Maintainability, Total effort (in days) to fix all the issues on the component and therefore to comply to all the requirements., -1, false, true, 4, 10321
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_technical_debt, Added Technical Debt, WORK_DUR, true, Maintainability, Added technical debt, -1, false, true, 4, 10322
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=sqale_rating, Maintainability Rating, RATING, true, Maintainability, A-to-E rating based on the technical debt ratio, -1, false, true, 4, 10153
2018.12.05 15:58:23 TRACE web[][sql] time=0ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=new_maintainability_rating, Maintainability Rating on New Code, RATING, true, Maintainability, Maintainability rating on new code, -1, false, true, 4, 10385
2018.12.05 15:58:23 TRACE web[][sql] time=1ms | sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=development_cost, Development Cost, STRING, true, Maintainability, Development cost, -1, true, true, 4, 10341
2018.12.05 15:58:23 ERROR web[][o.s.s.p.Platform] Background initialization failed. Stopping SonarQube
org.apache.ibatis.exceptions.PersistenceException:
### Error updating database.  Cause: java.sql.SQLException: Invalid argument(s) in call
### SQL: INSERT INTO metrics (     name, description, direction, domain, short_name, qualitative, val_type, user_managed, enabled, worst_value,     best_value, optimized_best_value, hidden, delete_historical_data, decimal_scale)     VALUES (     ?, ?, ?,     ?, ?, ?,     ?, ?, ?,     ?, ?,     ?, ?, ?,     ?     )
### Cause: java.sql.SQLException: Invalid argument(s) in call
        at org.apache.ibatis.exceptions.ExceptionFactory.wrapException(ExceptionFactory.java:30)
        at org.apache.ibatis.session.defaults.DefaultSqlSession.update(DefaultSqlSession.java:200)
        at org.apache.ibatis.session.defaults.DefaultSqlSession.insert(DefaultSqlSession.java:185)
        at org.apache.ibatis.binding.MapperMethod.execute(MapperMethod.java:58)
        at org.apache.ibatis.binding.MapperProxy.invoke(MapperProxy.java:59)
        at com.sun.proxy.$Proxy33.insert(Unknown Source)
        at org.sonar.db.metric.MetricDao.insert(MetricDao.java:84)
        at org.sonar.server.startup.RegisterMetrics.save(RegisterMetrics.java:91)
        at org.sonar.server.startup.RegisterMetrics.register(RegisterMetrics.java:69)
        at org.sonar.server.startup.RegisterMetrics.start(RegisterMetrics.java:63)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at org.picocontainer.lifecycle.ReflectionLifecycleStrategy.invokeMethod(ReflectionLifecycleStrategy.java:110)
        at org.picocontainer.lifecycle.ReflectionLifecycleStrategy.start(ReflectionLifecycleStrategy.java:89)
        at org.picocontainer.injectors.AbstractInjectionFactory$LifecycleAdapter.start(AbstractInjectionFactory.java:84)
        at org.picocontainer.behaviors.AbstractBehavior.start(AbstractBehavior.java:169)
        at org.picocontainer.behaviors.Stored$RealComponentLifecycle.start(Stored.java:132)
        at org.picocontainer.behaviors.Stored.start(Stored.java:110)
        at org.picocontainer.DefaultPicoContainer.potentiallyStartAdapter(DefaultPicoContainer.java:1016)
        at org.picocontainer.DefaultPicoContainer.startAdapters(DefaultPicoContainer.java:1009)
        at org.picocontainer.DefaultPicoContainer.start(DefaultPicoContainer.java:767)
        at org.sonar.core.platform.ComponentContainer.startComponents(ComponentContainer.java:135)
        at org.sonar.server.platform.platformlevel.PlatformLevel.start(PlatformLevel.java:90)
        at org.sonar.server.platform.platformlevel.PlatformLevelStartup.access$001(PlatformLevelStartup.java:46)
        at org.sonar.server.platform.platformlevel.PlatformLevelStartup$1.doPrivileged(PlatformLevelStartup.java:82)
        at org.sonar.server.user.DoPrivileged.execute(DoPrivileged.java:46)
        at org.sonar.server.platform.platformlevel.PlatformLevelStartup.start(PlatformLevelStartup.java:79)
        at org.sonar.server.platform.Platform.executeStartupTasks(Platform.java:196)
        at org.sonar.server.platform.Platform.access$400(Platform.java:46)
        at org.sonar.server.platform.Platform$1.lambda$doRun$1(Platform.java:121)
        at org.sonar.server.platform.Platform$AutoStarterRunnable.runIfNotAborted(Platform.java:371)
        at org.sonar.server.platform.Platform$1.doRun(Platform.java:121)
        at org.sonar.server.platform.Platform$AutoStarterRunnable.run(Platform.java:355)
        at java.lang.Thread.run(Thread.java:748)
Caused by: java.sql.SQLException: Invalid argument(s) in call
        at oracle.jdbc.driver.AutoKeyInfo.getNewSql(AutoKeyInfo.java:187)
        at oracle.jdbc.driver.PhysicalConnection.prepareStatement(PhysicalConnection.java:4342)
        at org.apache.commons.dbcp2.DelegatingConnection.prepareStatement(DelegatingConnection.java:771)
        at org.apache.commons.dbcp2.DelegatingConnection.prepareStatement(DelegatingConnection.java:771)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at org.sonar.db.profiling.InvocationUtils.invokeQuietly(InvocationUtils.java:34)
        at org.sonar.db.profiling.ProfilingConnectionHandler.invoke(ProfilingConnectionHandler.java:39)
        at com.sun.proxy.$Proxy15.prepareStatement(Unknown Source)
        at org.apache.ibatis.executor.statement.PreparedStatementHandler.instantiateStatement(PreparedStatementHandler.java:82)
        at org.apache.ibatis.executor.statement.BaseStatementHandler.prepare(BaseStatementHandler.java:88)
        at org.apache.ibatis.executor.statement.RoutingStatementHandler.prepare(RoutingStatementHandler.java:59)
        at org.apache.ibatis.executor.ReuseExecutor.prepareStatement(ReuseExecutor.java:89)
        at org.apache.ibatis.executor.ReuseExecutor.doUpdate(ReuseExecutor.java:51)
        at org.apache.ibatis.executor.BaseExecutor.update(BaseExecutor.java:117)
        at org.apache.ibatis.executor.CachingExecutor.update(CachingExecutor.java:76)
        at org.apache.ibatis.session.defaults.DefaultSqlSession.update(DefaultSqlSession.java:198)
        ... 34 common frames omitted

(Serdar) #6

It’s still down


(Serdar) #7

This line :

sql=update metrics set name=?, short_name=?, val_type=?, enabled=?, domain=?, description=?, direction=?, hidden=?, qualitative=?, decimal_scale=? where id=? | params=development_cost, Development Cost, STRING, true, Maintainability, Development cost, -1, true, true, 4, 10341

is not correct. because Sonar try to put this sql :
sql=update metrics set name=params=‘development_cost’, short_name=‘Development Cost’, val_type=STRING, enabled=true, domain=Maintainability, description=Development cost, direction=-1, hidden=true, qualitative=true, decimal_scale=4 where id=10341.
However, for example, the type of qualitative colonne is a number and not a boolean.

ID                                                    NUMBER(38,0)   No                    1         
NAME                                              VARCHAR2(64 BYTE)       No                    2         
DESCRIPTION                                 VARCHAR2(4000 BYTE)   Yes                   3         
DIRECTION                                      NUMBER(38,0)   No        0          4         
DOMAIN                                           VARCHAR2(64 BYTE)       Yes                   5         
SHORT_NAME                                 VARCHAR2(64 BYTE)       Yes                   6         
QUALITATIVE                                   NUMBER(1,0)     No        0          7         
VAL_TYPE                                       VARCHAR2(8 BYTE)        Yes                   8         
USER_MANAGED                            NUMBER(1,0)     Yes       0          9         
ENABLED                                         NUMBER(1,0)     Yes       1          10        
WORST_VALUE                               NUMBER(38,20) Yes                   11        
BEST_VALUE                                   NUMBER(38,20) Yes                   12        
OPTIMIZED_BEST_VALUE               NUMBER(1,0)     Yes                   13        
HIDDEN                                            NUMBER(1,0)     Yes                   14        
DELETE_HISTORICAL_DATA          NUMBER(1,0)     Yes                   15        
DECIMAL_SCALE                            NUMBER(38,0)   Yes                   16

(Serdar) #9

Hi,

You can close this post.
The problem was the jdbc-driver.
I changed ojdbc8-12.2.0.1.jar by ojdbc7-12.1.0.2.jar then that worked.

Thank you.


(G Ann Campbell) #10

Thanks for following up!