#1 2018-04-12 21:14:04

gary.knapp
Member
Registered: 2016-05-12

Upgraded to RS3.0.3-6002 Runs but crashes

I upgraded a hosted server with  10.x.x.x and 172.x.x.x addresses.  The log shows three config files, not loading and an Error in the internal DB startup. The reportserver_dba user is set up with both IP addresses in MariaDB.


16:01:35.809 INFO  n.datenwerke.rs.EnvironmentValidator -




  _____                       _    _____                         
|  __ \                     | |  / ____|                         
| |__) |___ _ __   ___  _ __| |_| (___   ___ _ ____   _____ _ __
|  _  // _ \ '_ \ / _ \| '__| __|\___ \ / _ \ '__\ \ / / _ \ '__|
| | \ \  __/ |_) | (_) | |  | |_ ____) |  __/ |   \ V /  __/ |   
|_|  \_\___| .__/ \___/|_|   \__|_____/ \___|_|    \_/ \___|_|   
            | |                                                   
            |_|                                                   

Version: RS3.0.3-6002 2017-12-09-12-26-19
Code Version: 2017-12-08-10-49-15
Java Version: Oracle Corporation OpenJDK 64-Bit Server VM 25.161-b14 (1.8)
VM Args: -Djava.util.logging.config.file=/data/opt/tomcat/conf/logging.properties -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager -Xms1024m -Xmx6144m -Drs.configdir=/var/lib/rsconfig -Djdk.tls.ephemeralDHKeySize=2048 -Djava.endorsed.dirs=/data/opt/tomcat/endorsed -Dcatalina.base=/data/opt/tomcat -Dcatalina.home=/data/opt/tomcat -Djava.io.tmpdir=/data/opt/tomcat/temp
rs.configdir: /var/lib/rsconfig (OK)

### DB Config ###
hibernate.dialect: net.datenwerke.rs.utils.hibernate.MySQL5Dialect (OK)
hibernate.connection.driver_class: com.mysql.jdbc.Driver (OK)
hibernate.connection.url: jdbc:mysql://10.147.46.10:3306/reportserver (OK)
hibernate.connection.username: reportserver_dba
hibernate.connection.password: *********
hibernate.default_schema:

Connection Test: OK
Schema Version: RS3.0-9

16:01:35.818 INFO  n.datenwerke.rs.EnvironmentValidator - Validating database schema...
16:01:55.898 INFO  n.datenwerke.rs.EnvironmentValidator - Schema validation completed
16:01:56.397 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.AdminResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.AdminResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.BasicRepositoryResource2
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.BasicRepositoryResource2
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.DataSourceResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.DataSourceResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.ExporterResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.ExporterResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.FilterRepositoryResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.FilterRepositoryResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.InfoResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.InfoResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.License
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.License
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.OlapDiscoverResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.OlapDiscoverResource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.Query2Resource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.Query2Resource
16:01:56.398 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.SessionResource
16:01:56.399 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.SessionResource
16:01:56.399 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.SaikuI18nResource
16:01:56.399 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.SaikuI18nResource
16:01:56.399 INFO  n.d.r.s.server.rest.SaikuRestModule - try to bind: net.datenwerke.rs.saiku.server.rest.resources.StatisticsResource
16:01:56.399 INFO  n.d.r.s.server.rest.SaikuRestModule - done binding: net.datenwerke.rs.saiku.server.rest.resources.StatisticsResource
16:01:59.272 WARN  n.d.r.c.s.c.ConfigServiceImpl - Configfile scheduler/scheduler.cf could not be loaded. Default values are in effect.
16:01:59.274 WARN  n.d.r.c.s.c.ConfigServiceImpl - Configfile exportfilemd/pdfexport.cf could not be loaded. Default values are in effect.
16:01:59.275 WARN  n.d.r.c.s.c.ConfigServiceImpl - Configfile exportfilemd/pdfexport.cf could not be loaded. Default values are in effect.
16:01:59.399 INFO  n.d.r.s.s.saiku.OlapUtilServiceImpl - loaded olap util service
16:01:59.401 INFO  n.d.r.s.s.saiku.ThinQueryServiceImpl - loaded thinqueryservice
16:02:25.195 INFO  n.d.r.c.s.i.RemoteMessageServiceImpl - Loading messages...
16:02:25.241 INFO  n.d.r.c.s.j.h.ReportServerExtenderHooker - Start loading ReportServer extensions.
16:02:30.603 ERROR n.d.r.c.s.i.InternalDbStartup - Error in Internal DB Startup
java.lang.RuntimeException: java.sql.SQLException: null,  message from server: "Host '172.24.16.134' is not allowed to connect to this MariaDB server"
    at net.datenwerke.dbpool.DbC3p0PoolServiceImpl$1.get(DbC3p0PoolServiceImpl.java:189) ~[reportserver.jar:na]
    at net.datenwerke.dbpool.DbC3p0PoolServiceImpl$1.get(DbC3p0PoolServiceImpl.java:1) ~[reportserver.jar:na]
    at net.datenwerke.rs.core.service.internaldb.TempTableServiceImpl.dropRSTMPtables(TempTableServiceImpl.java:70) ~[reportserver.jar:na]
    at net.datenwerke.rs.core.service.internaldb.InternalDbStartup$1.initialize(InternalDbStartup.java:45) ~[reportserver.jar:na]
    at net.datenwerke.gf.service.lateinit.LateInitStartup$1.run(LateInitStartup.java:62) [reportserver.jar:na]
    at java.lang.Thread.run(Thread.java:748) [na:1.8.0_161]
Caused by: java.sql.SQLException: null,  message from server: "Host '172.24.16.134' is not allowed to connect to this MariaDB server"
    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:957) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:896) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:885) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.MysqlIO.doHandshake(MysqlIO.java:1038) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.ConnectionImpl.coreConnect(ConnectionImpl.java:2255) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.ConnectionImpl.connectOneTryOnly(ConnectionImpl.java:2286) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.ConnectionImpl.createNewIO(ConnectionImpl.java:2085) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.ConnectionImpl.<init>(ConnectionImpl.java:795) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.JDBC4Connection.<init>(JDBC4Connection.java:44) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at sun.reflect.GeneratedConstructorAccessor122.newInstance(Unknown Source) ~[na:na]
    at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[na:1.8.0_161]
    at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[na:1.8.0_161]
    at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.ConnectionImpl.getInstance(ConnectionImpl.java:400) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mysql.jdbc.NonRegisteringDriver.connect(NonRegisteringDriver.java:327) ~[mysql-connector-java-5.1.38.jar:5.1.38]
    at com.mchange.v2.c3p0.DriverManagerDataSource.getConnection(DriverManagerDataSource.java:175) ~[c3p0-0.9.5.jar:0.9.5]
    at com.mchange.v2.c3p0.WrapperConnectionPoolDataSource.getPooledConnection(WrapperConnectionPoolDataSource.java:220) ~[c3p0-0.9.5.jar:0.9.5]
    at com.mchange.v2.c3p0.impl.C3P0PooledConnectionPool$1PooledConnectionResourcePoolManager.acquireResource(C3P0PooledConnectionPool.java:211) ~[c3p0-0.9.5.jar:0.9.5]
    at com.mchange.v2.resourcepool.BasicResourcePool.doAcquire(BasicResourcePool.java:1127) ~[c3p0-0.9.5.jar:0.9.5]
    at com.mchange.v2.resourcepool.BasicResourcePool.doAcquireAndDecrementPendingAcquiresWithinLockOnSuccess(BasicResourcePool.java:1114) ~[c3p0-0.9.5.jar:0.9.5]
    at com.mchange.v2.resourcepool.BasicResourcePool.access$800(BasicResourcePool.java:44) ~[c3p0-0.9.5.jar:0.9.5]
    at com.mchange.v2.resourcepool.BasicResourcePool$ScatteredAcquireTask.run(BasicResourcePool.java:1855) ~[c3p0-0.9.5.jar:0.9.5]
    at com.mchange.v2.async.ThreadPoolAsynchronousRunner$PoolThread.run(ThreadPoolAsynchronousRunner.java:696) ~[mchange-commons-java-0.2.9.jar:0.2.9]
16:02:31.278 INFO  n.d.r.c.s.i.RemoteMessageServiceImpl - Available locales: de, fi, ru, pt, bg, keys, lt, hr, lv, fr, hu, zh-CN, sk, sl, ga, sv, zh-TW, el, mt, en, it, es, et, cs, pl, da, ro, nl, tr
16:02:31.296 INFO  n.d.r.s.s.saiku.OlapUtilServiceImpl - loaded olap util service
16:03:04.035 INFO  n.d.r.s.s.search.SearchServiceImpl - Rebuilding search index...
16:03:08.455 INFO  n.d.g.s.lateinit.LateInitStartup - Startup completed

Offline

#2 2018-04-16 07:41:34

eduardo
Administrator
Registered: 2016-11-01
Website

Re: Upgraded to RS3.0.3-6002 Runs but crashes

Hi gary.knapp

this error comes from your mariaDB installation:
""Host '172.24.16.134' is not allowed to connect to this MariaDB server""

Please make sure that you can connect to the MariaDB server with the host specified.

Regards,
Eduardo

Offline

#3 2018-04-17 14:27:56

gary.knapp
Member
Registered: 2016-05-12

Re: Upgraded to RS3.0.3-6002 Runs but crashes

Thanks, I found the Datasource that was incorrectly configured.

Offline

Board footer

Powered by FluxBB