Ubuntu server 18.04 deploy error

simob · October 20, 2020, 12:31am

Hi, I’m trying to install on a ubuntu 18.04 server but I can’t deploy the application. I followed all the steps of the installation instructions exactly. Tomcat works but I cannot deploy the application. I checked everything … path, environment variables, permissions,
I attach the Tomcat logs and hope that someone notices something that I missed and can help me.
My configuration is:

Ubuntu 18.04
Zulu JDK 7
MySQL 5.7.31
Tomcat 7.0.106

Thanks in advance.

Log

Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Server version name:   Apache Tomcat/7.0.106
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Server built:          Sep 16 2020 08:33:41 UTC
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Server version number: 7.0.106.0
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: OS Name:               Linux
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: OS Version:            4.15.0-121-generic
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Architecture:          amd64
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Java Home:             /usr/lib/jvm/zulu-7-amd64/jre
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: JVM Version:           1.7.0_272-b10
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: JVM Vendor:            Azul Systems, Inc.
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: CATALINA_BASE:         /opt/tomcat
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: CATALINA_HOME:         /opt/tomcat
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Djava.util.logging.config.file=/opt/tomcat/conf/logging.properties
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Djava.awt.headless=true
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Djava.security.egd=file:/dev/./urandom
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Djdk.tls.ephemeralDHKeySize=2048
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Dorg.apache.catalina.security.SecurityListener.UMASK=0027
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Xms1024m
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Xmx1024m
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -XX:MaxPermSize=1024m
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -XX:+UseParallelGC
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Dignore.endorsed.dirs=
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Dcatalina.base=/opt/tomcat
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Dcatalina.home=/opt/tomcat
Oct 19, 2020 11:40:44 PM org.apache.catalina.startup.VersionLoggerListener log
INFO: Command line argument: -Djava.io.tmpdir=/opt/tomcat/temp
Oct 19, 2020 11:40:44 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The Apache Tomcat Native library which allows using OpenSSL was not found on the java.library.path: [/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib]
Oct 19, 2020 11:40:45 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8080"]
Oct 19, 2020 11:40:45 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 1933 ms
Oct 19, 2020 11:40:45 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service [Catalina]
Oct 19, 2020 11:40:45 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.106
Oct 19, 2020 11:40:45 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive [/opt/apache-tomcat-7.0.106/webapps/openboxes.war]
Oct 19, 2020 11:41:01 PM org.apache.catalina.startup.TldConfig execute
INFO: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
Oct 19, 2020 11:41:45 PM org.apache.catalina.core.StandardContext startInternal
SEVERE: One or more listeners failed to start. Full details will be found in the appropriate container log file
Oct 19, 2020 11:41:45 PM org.apache.catalina.core.StandardContext startInternal
SEVERE: Context [/openboxes] startup failed due to previous errors
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesJdbc
SEVERE: The web application [/openboxes] registered the JDBC driver [com.mysql.jdbc.Driver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [C3P0PooledConnectionPoolManager[identityToken->1hgeas7adijc7vi14wy2p3|1d69f39e]-AdminTaskTimer] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [C3P0PooledConnectionPoolManager[identityToken->1hgeas7adijc7vi14wy2p3|1d69f39e]-HelperThread-#0] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [C3P0PooledConnectionPoolManager[identityToken->1hgeas7adijc7vi14wy2p3|1d69f39e]-HelperThread-#1] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [C3P0PooledConnectionPoolManager[identityToken->1hgeas7adijc7vi14wy2p3|1d69f39e]-HelperThread-#2] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [C3P0PooledConnectionPoolManager[identityToken->1hgeas7adijc7vi14wy2p3|1d69f39e]-DeferredStatementDestroyerThread-#0] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Abandoned connection cleanup thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [net.sf.ehcache.CacheManager@53fa0728] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store dashboardCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store messageCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store dashboardTotalStockValueCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store dashboardProductSummaryCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store fastMoversCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store quantityOnHandCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store binLocationSummaryCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store inventorySnapshotCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store megamenuCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store selectTagsCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-1] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-2] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-3] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-4] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-5] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-6] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-7] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-8] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-9] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_Worker-10] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store binLocationReportCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store selectCatalogsCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store inventoryBrowserCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store selectTagCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store selectCategoryCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Store dashboardGenericProductSummaryCache Spool Thread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [Timer-0] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
SEVERE: The web application [/openboxes] appears to have started a thread named [DefaultPluginScheduler_QuartzSchedulerThread] but has failed to stop it. This is very likely to create a memory leak.
Oct 19, 2020 11:41:45 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive [/opt/apache-tomcat-7.0.106/webapps/openboxes.war] has finished in [59,715] ms
Oct 19, 2020 11:41:45 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory [/opt/apache-tomcat-7.0.106/webapps/host-manager]
Oct 19, 2020 11:41:45 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory [/opt/apache-tomcat-7.0.106/webapps/host-manager] has finished in [125] ms
Oct 19, 2020 11:41:45 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory [/opt/apache-tomcat-7.0.106/webapps/examples]
Oct 19, 2020 11:41:45 PM org.apache.catalina.loader.WebappClassLoaderBase findResourceInternal
INFO: Illegal access: this web application instance has been stopped already. Could not load []. The following stack trace is thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access.
Oct 19, 2020 11:41:45 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory [/opt/apache-tomcat-7.0.106/webapps/examples] has finished in [459] ms
Oct 19, 2020 11:41:45 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory [/opt/apache-tomcat-7.0.106/webapps/manager]
Oct 19, 2020 11:41:46 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory [/opt/apache-tomcat-7.0.106/webapps/manager] has finished in [96] ms
Oct 19, 2020 11:41:46 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory [/opt/apache-tomcat-7.0.106/webapps/docs]
Oct 19, 2020 11:41:46 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory [/opt/apache-tomcat-7.0.106/webapps/docs] has finished in [53] ms
Oct 19, 2020 11:41:46 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory [/opt/apache-tomcat-7.0.106/webapps/ROOT]
Oct 19, 2020 11:41:46 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory [/opt/apache-tomcat-7.0.106/webapps/ROOT] has finished in [54] ms
Oct 19, 2020 11:41:46 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Oct 19, 2020 11:41:46 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 60839 ms
Oct 19, 2020 11:42:00 PM org.apache.catalina.loader.WebappClassLoaderBase loadClass
INFO: Illegal access: this web application instance has been stopped already. Could not load [org.quartz.ExecuteInJTATransaction]. The following stack trace is thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access.
java.lang.IllegalStateException
	at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1837)
	at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1795)
	at org.quartz.ee.jta.JTAAnnotationAwareJobRunShellFactory.createJobRunShell(JTAAnnotationAwareJobRunShellFactory.java:100)
	at org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:386)

jmiranda · October 20, 2020, 12:34am

Thanks for the post @simob. It’s weird. I don’t see anything in the logs that gives any indication of what’s wrong. Can you send me the full catalina.out file to support@openboxes.com?

simob · October 20, 2020, 9:09pm

I have sent you my catalina.out at support@openboxes.com
Thanks for your help

jmiranda · October 20, 2020, 9:10pm

Thanks @simob. I’ll get back to you shortly.

jmiranda · October 20, 2020, 9:29pm

Wow. I have seen a lot of stacktraces but I have honestly never seen this before. I think our best bet is to drop the database and start again.

$ mysql -u root -p

mysql> drop database openboxes;
mysql> create database openboxes default charset utf8;
mysql> grant all on openboxes.* to openboxes@localhost;
mysql> quit

$ sudo service tomcat restart

Here’s the error that I’m seeing in your catalina.out file.

2020-10-20 22:29:27,892 [localhost-startStop-1] INFO  bootstrap.BootStrap  - Running liquibase changelog(s) ...
2020-10-20 22:29:28,070 [localhost-startStop-1] INFO  bootstrap.BootStrap  - Liquibase running: false
2020-10-20 22:29:28,075 [localhost-startStop-1] INFO  bootstrap.BootStrap  - Setting default schema to openboxes
2020-10-20 22:29:28,076 [localhost-startStop-1] INFO  bootstrap.BootStrap  - Product Version: 5.7.31-0ubuntu0.18.04.1
2020-10-20 22:29:28,076 [localhost-startStop-1] INFO  bootstrap.BootStrap  - Database Version: 5.7
2020-10-20 22:29:28,078 [localhost-startStop-1] INFO  liquibase  - Reading from `DATABASECHANGELOG`
2020-10-20 22:29:28,117 [localhost-startStop-1] INFO  liquibase  - Lock Database
2020-10-20 22:29:28,130 [localhost-startStop-1] INFO  liquibase  - Successfully acquired change log lock
2020-10-20 22:29:30,138 [localhost-startStop-1] INFO  liquibase  - Changeset 0.5.x/alter-table-engine-innodb.xml::1351380063409::jmiranda::(MD5Sum: 8d2df8a4ebe0d98ee951153c8a59ca6)
2020-10-20 22:29:32,534 [localhost-startStop-1] INFO  liquibase  - Release Database Lock
2020-10-20 22:29:32,536 [localhost-startStop-1] INFO  liquibase  - Successfully released change log lock
2020-10-20 22:29:32,544 [localhost-startStop-1] ERROR context.ContextLoader  - Context initialization failed
org.springframework.beans.factory.access.BootstrapException: Error executing bootstraps; nested exception is org.codehaus.groovy.runtime.InvokerInvocationException: liquibase.exception.MigrationFailedException: Migration failed for change set 0.5.x/alter-table-engine-innodb.xml::1351380063409::jmiranda:
     Reason: liquibase.exception.JDBCException: Error executing SQL 			ALTER TABLE `unit_of_measure_class` ENGINE=InnoDB:
          Caused By: Error executing SQL 			ALTER TABLE `unit_of_measure_class` ENGINE=InnoDB:
          Caused By: Table 'openboxes.unit_of_measure_class' doesn't exist
	at org.codehaus.groovy.grails.web.context.GrailsContextLoader.createWebApplicationContext(GrailsContextLoader.java:87)
	at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:197)
	at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:47)
	at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:5128)
	at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5653)
	at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183)
	at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:1007)
	at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:983)
	at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:639)
	at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1127)
	at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:2019)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:473)
	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1152)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:622)
	at java.lang.Thread.run(Thread.java:748)
Caused by: org.codehaus.groovy.runtime.InvokerInvocationException: liquibase.exception.MigrationFailedException: Migration failed for change set 0.5.x/alter-table-engine-innodb.xml::1351380063409::jmiranda:
     Reason: liquibase.exception.JDBCException: Error executing SQL 			ALTER TABLE `unit_of_measure_class` ENGINE=InnoDB:
          Caused By: Error executing SQL 			ALTER TABLE `unit_of_measure_class` ENGINE=InnoDB:
          Caused By: Table 'openboxes.unit_of_measure_class' doesn't exist
	at grails.util.Environment.evaluateEnvironmentSpecificBlock(Environment.java:251)
	at grails.util.Environment.executeForEnvironment(Environment.java:244)
	at grails.util.Environment.executeForCurrentEnvironment(Environment.java:220)
	... 5 more
Caused by: liquibase.exception.MigrationFailedException: Migration failed for change set 0.5.x/alter-table-engine-innodb.xml::1351380063409::jmiranda:
     Reason: liquibase.exception.JDBCException: Error executing SQL 			ALTER TABLE `unit_of_measure_class` ENGINE=InnoDB:
          Caused By: Error executing SQL 			ALTER TABLE `unit_of_measure_class` ENGINE=InnoDB:
          Caused By: Table 'openboxes.unit_of_measure_class' doesn't exist
	at liquibase.ChangeSet.execute(ChangeSet.java:238)
	at liquibase.parser.visitor.UpdateVisitor.visit(UpdateVisitor.java:26)
	at liquibase.parser.ChangeLogIterator.run(ChangeLogIterator.java:41)
	at liquibase.Liquibase.update(Liquibase.java:112)
	at liquibase.Liquibase$update.call(Unknown Source)
	at BootStrap$_closure1.doCall(BootStrap.groovy:450)
	... 8 more
Caused by: liquibase.exception.JDBCException: Error executing SQL 			ALTER TABLE `unit_of_measure_class` ENGINE=InnoDB
	at liquibase.database.template.JdbcTemplate.execute(JdbcTemplate.java:55)
	at liquibase.database.template.JdbcTemplate.execute(JdbcTemplate.java:86)
	at liquibase.change.AbstractChange.execute(AbstractChange.java:247)
	at liquibase.change.AbstractChange.executeStatements(AbstractChange.java:93)
	at liquibase.ChangeSet.execute(ChangeSet.java:214)
	... 13 more
Caused by: com.mysql.jdbc.exceptions.jdbc4.MySQLSyntaxErrorException: Table 'openboxes.unit_of_measure_class' doesn't exist
	at com.mysql.jdbc.Util.handleNewInstance(Util.java:425)
	at com.mysql.jdbc.Util.getInstance(Util.java:408)
	at com.mysql.jdbc.SQLError.createSQLException(SQLError.java:944)
	at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3978)
	at com.mysql.jdbc.MysqlIO.checkErrorPacket(MysqlIO.java:3914)
	at com.mysql.jdbc.MysqlIO.sendCommand(MysqlIO.java:2530)
	at com.mysql.jdbc.MysqlIO.sqlQueryDirect(MysqlIO.java:2683)
	at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2491)
	at com.mysql.jdbc.ConnectionImpl.execSQL(ConnectionImpl.java:2449)
	at com.mysql.jdbc.StatementImpl.executeInternal(StatementImpl.java:845)
	at com.mysql.jdbc.StatementImpl.execute(StatementImpl.java:745)
	at com.mchange.v2.c3p0.impl.NewProxyStatement.execute(NewProxyStatement.java:75)
	at liquibase.database.template.JdbcTemplate$1ExecuteStatementCallback.doInStatement(JdbcTemplate.java:78)
	at liquibase.database.template.JdbcTemplate.execute(JdbcTemplate.java:48)
	... 17 more

jmiranda · October 20, 2020, 9:31pm

Please note that the database migration (creation) process takes a bit of time (10-20 minutes on average). Don’t stop the server while it’s running. You can check on the progress by tailing the catalina.out file as needed.

sudo tail -f /opt/apache-tomcat-7.0.106/logs/catalina.out

simob · October 20, 2020, 10:38pm

Great!! It works.
I have also verified that the support is excellent and I can evaluate the use in production.
We will be back soon for questions about customization and usage.
Thank you so much … especially from my wife who hasn’t seen me for two nights …

jmiranda · October 21, 2020, 3:38am

Yay! Glad to hear you got it working.