Installation Failed on linux ubuntu 18.04.5 LTS

ignalbertsh · October 20, 2020, 3:33am

Hello,
I got an error when starting the ignition gateway, below is the line

Ignition Successfully Installed

The wizard has finished installing Ignition on your computer.

Start Ignition Now [Y/n]: Y
Install Service [Y/n]: n
INFO [IgnitionInstaller ] [2020/10/16 01:13:19]: Starting Gateway.
This should only take a moment..
WARN [IgnitionInstaller ] [2020/10/16 01:14:06]: Unable to start
gateway
com.inductiveautomation.ignition.installer.common.actions.InstallAction$WarnInstallException:
java.util.concurrent.ExecutionException: java.lang.Exception: Java
process exec failed with error code 1: Starting Ignition-Gateway...
Waiting for Ignition-Gateway..........................
WARNING: Ignition-Gateway may have failed to start.

at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.install.StartGatewayAction.execute(StartGatewayAction.java:63)
at
com.inductiveautomation.ignition.installer.offline/com.inductiveautomation.ignition.installer.offline.OfflineInstaller.finishInstall(OfflineInstaller.java:401)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.ui.text.InstallerTextApplication.lambda$exitSuccessfully$6(InstallerTextApplication.java:272)
at java.base/java.lang.Thread.run(Thread.java:834)
java.util.concurrent.ExecutionException: java.lang.Exception: Java
process exec failed with error code 1: Starting Ignition-Gateway...
Waiting for Ignition-Gateway..........................
WARNING: Ignition-Gateway may have failed to start.

at
java.base/java.util.concurrent.CompletableFuture.reportGet(CompletableFuture.java:395)
at
java.base/java.util.concurrent.CompletableFuture.get(CompletableFuture.java:1999)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.common.AbstractGatewayCommandAction.executeCommand(AbstractGatewayCommandAction.java:255)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.common.AbstractGatewayCommandAction.executeCommand(AbstractGatewayCommandAction.java:208)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.common.AbstractGatewayCommandAction.executeWrapperStartCommand(AbstractGatewayCommandAction.java:147)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.install.StartGatewayAction.execute(StartGatewayAction.java:55)
at
com.inductiveautomation.ignition.installer.offline/com.inductiveautomation.ignition.installer.offline.OfflineInstaller.finishInstall(OfflineInstaller.java:401)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.ui.text.InstallerTextApplication.lambda$exitSuccessfully$6(InstallerTextApplication.java:272)
at java.base/java.lang.Thread.run(Thread.java:834)
java.lang.Exception: Java process exec failed with error code 1:
Starting Ignition-Gateway...
Waiting for Ignition-Gateway..........................
WARNING: Ignition-Gateway may have failed to start.

at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.common.AbstractGatewayCommandAction.lambda$executeCommand$2(AbstractGatewayCommandAction.java:245)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.utils.ProcessUtils.lambda$waitForProcessToFinish$5(ProcessUtils.java:168)
at java.base/java.util.Optional.ifPresentOrElse(Optional.java:201)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.utils.ProcessUtils.lambda$waitForProcessToFinish$7(ProcessUtils.java:158)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.utils.ProcessUtils.waitForProcessToFinish(ProcessUtils.java:182)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.common.AbstractGatewayCommandAction.executeCommand(AbstractGatewayCommandAction.java:244)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.common.AbstractGatewayCommandAction.executeCommand(AbstractGatewayCommandAction.java:208)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.common.AbstractGatewayCommandAction.executeWrapperStartCommand(AbstractGatewayCommandAction.java:147)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.actions.install.StartGatewayAction.execute(StartGatewayAction.java:55)
at
com.inductiveautomation.ignition.installer.offline/com.inductiveautomation.ignition.installer.offline.OfflineInstaller.finishInstall(OfflineInstaller.java:401)
at
com.inductiveautomation.ignition.installer.common/com.inductiveautomation.ignition.installer.common.ui.text.InstallerTextApplication.lambda$exitSuccessfully$6(InstallerTextApplication.java:272)
at java.base/java.lang.Thread.run(Thread.java:834)

Thank you

James.Lorenz · October 20, 2020, 4:46am

Can you post the contents of the wrapper.log? It can be found in the logs directory of wherever you installed Ignition.

ignalbertsh · October 20, 2020, 5:06am

This is the content of wrapper.log file

STATUS | wrapper | 2020/10/20 05:01:29 | --> Wrapper Started as Daemon
STATUS | wrapper | 2020/10/20 05:01:29 | Java Service Wrapper Standard Edition 64-bit 3.5.42
STATUS | wrapper | 2020/10/20 05:01:29 | Copyright (C) 1999-2020 Tanuki Software, Ltd. All Rights Reserved.
STATUS | wrapper | 2020/10/20 05:01:29 | http://wrapper.tanukisoftware.com
STATUS | wrapper | 2020/10/20 05:01:29 | Licensed to Inductive Automation for Inductive Automation
STATUS | wrapper | 2020/10/20 05:01:29 |
STATUS | wrapper | 2020/10/20 05:01:29 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:01:29 | JVM exited while loading the application.
INFO | jvm 1 | 2020/10/20 05:01:29 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 1 | 2020/10/20 05:01:29 | #
INFO | jvm 1 | 2020/10/20 05:01:29 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 1 | 2020/10/20 05:01:29 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 1 | 2020/10/20 05:01:29 | # An error report file with more information is saved as:
INFO | jvm 1 | 2020/10/20 05:01:29 | # /usr/local/bin/ignition/hs_err_pid2210.log
STATUS | wrapper | 2020/10/20 05:01:35 | Reloading Wrapper configuration...
STATUS | wrapper | 2020/10/20 05:01:35 | JVM process is gone.
STATUS | wrapper | 2020/10/20 05:01:35 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:01:35 | JVM exited while loading the application.
INFO | jvm 2 | 2020/10/20 05:01:35 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 2 | 2020/10/20 05:01:35 | #
INFO | jvm 2 | 2020/10/20 05:01:35 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 2 | 2020/10/20 05:01:35 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 2 | 2020/10/20 05:01:35 | # An error report file with more information is saved as:
INFO | jvm 2 | 2020/10/20 05:01:35 | # /usr/local/bin/ignition/hs_err_pid2250.log
STATUS | wrapper | 2020/10/20 05:01:40 | Reloading Wrapper configuration...
STATUS | wrapper | 2020/10/20 05:01:40 | JVM process is gone.
STATUS | wrapper | 2020/10/20 05:01:41 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:01:41 | JVM exited while loading the application.
INFO | jvm 3 | 2020/10/20 05:01:41 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 3 | 2020/10/20 05:01:41 | #
INFO | jvm 3 | 2020/10/20 05:01:41 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 3 | 2020/10/20 05:01:41 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 3 | 2020/10/20 05:01:41 | # An error report file with more information is saved as:
INFO | jvm 3 | 2020/10/20 05:01:41 | # /usr/local/bin/ignition/hs_err_pid2283.log
STATUS | wrapper | 2020/10/20 05:01:46 | Reloading Wrapper configuration...
STATUS | wrapper | 2020/10/20 05:01:46 | JVM process is gone.
STATUS | wrapper | 2020/10/20 05:01:46 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:01:46 | JVM exited while loading the application.
INFO | jvm 4 | 2020/10/20 05:01:46 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 4 | 2020/10/20 05:01:46 | #
INFO | jvm 4 | 2020/10/20 05:01:46 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 4 | 2020/10/20 05:01:46 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 4 | 2020/10/20 05:01:46 | # An error report file with more information is saved as:
INFO | jvm 4 | 2020/10/20 05:01:46 | # /usr/local/bin/ignition/hs_err_pid2322.log
STATUS | wrapper | 2020/10/20 05:01:51 | Reloading Wrapper configuration...
STATUS | wrapper | 2020/10/20 05:01:51 | JVM process is gone.
STATUS | wrapper | 2020/10/20 05:01:52 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:01:52 | JVM exited while loading the application.
INFO | jvm 5 | 2020/10/20 05:01:52 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 5 | 2020/10/20 05:01:52 | #
INFO | jvm 5 | 2020/10/20 05:01:52 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 5 | 2020/10/20 05:01:52 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 5 | 2020/10/20 05:01:52 | # An error report file with more information is saved as:
INFO | jvm 5 | 2020/10/20 05:01:52 | # /usr/local/bin/ignition/hs_err_pid2355.log
FATAL | wrapper | 2020/10/20 05:01:52 | There were 5 failed launches in a row, each lasting less than 300 seconds. Giving up.
FATAL | wrapper | 2020/10/20 05:01:52 | There may be a configuration problem: please check the logs.
STATUS | wrapper | 2020/10/20 05:01:52 | <-- Wrapper Stopped
STATUS | wrapper | 2020/10/20 05:01:53 | --> Wrapper Started as Daemon
STATUS | wrapper | 2020/10/20 05:01:53 | Java Service Wrapper Standard Edition 64-bit 3.5.42
STATUS | wrapper | 2020/10/20 05:01:53 | Copyright (C) 1999-2020 Tanuki Software, Ltd. All Rights Reserved.
STATUS | wrapper | 2020/10/20 05:01:53 | http://wrapper.tanukisoftware.com
STATUS | wrapper | 2020/10/20 05:01:53 | Licensed to Inductive Automation for Inductive Automation
STATUS | wrapper | 2020/10/20 05:01:53 |
STATUS | wrapper | 2020/10/20 05:01:53 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:01:53 | JVM exited while loading the application.
INFO | jvm 1 | 2020/10/20 05:01:53 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 1 | 2020/10/20 05:01:53 | #
INFO | jvm 1 | 2020/10/20 05:01:53 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 1 | 2020/10/20 05:01:53 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 1 | 2020/10/20 05:01:53 | # An error report file with more information is saved as:
INFO | jvm 1 | 2020/10/20 05:01:53 | # /usr/local/bin/ignition/hs_err_pid2560.log
STATUS | wrapper | 2020/10/20 05:01:58 | Reloading Wrapper configuration...
STATUS | wrapper | 2020/10/20 05:01:59 | JVM process is gone.
STATUS | wrapper | 2020/10/20 05:01:59 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:01:59 | JVM exited while loading the application.
INFO | jvm 2 | 2020/10/20 05:01:59 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 2 | 2020/10/20 05:01:59 | #
INFO | jvm 2 | 2020/10/20 05:01:59 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 2 | 2020/10/20 05:01:59 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 2 | 2020/10/20 05:01:59 | # An error report file with more information is saved as:
INFO | jvm 2 | 2020/10/20 05:01:59 | # /usr/local/bin/ignition/hs_err_pid2598.log
STATUS | wrapper | 2020/10/20 05:02:04 | Reloading Wrapper configuration...
STATUS | wrapper | 2020/10/20 05:02:04 | JVM process is gone.
STATUS | wrapper | 2020/10/20 05:02:04 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:02:04 | JVM exited while loading the application.
INFO | jvm 3 | 2020/10/20 05:02:04 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 3 | 2020/10/20 05:02:04 | #
INFO | jvm 3 | 2020/10/20 05:02:04 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 3 | 2020/10/20 05:02:04 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 3 | 2020/10/20 05:02:04 | # An error report file with more information is saved as:
INFO | jvm 3 | 2020/10/20 05:02:04 | # /usr/local/bin/ignition/hs_err_pid2633.log
STATUS | wrapper | 2020/10/20 05:02:10 | Reloading Wrapper configuration...
STATUS | wrapper | 2020/10/20 05:02:10 | JVM process is gone.
STATUS | wrapper | 2020/10/20 05:02:10 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:02:10 | JVM exited while loading the application.
INFO | jvm 4 | 2020/10/20 05:02:10 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 4 | 2020/10/20 05:02:10 | #
INFO | jvm 4 | 2020/10/20 05:02:10 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 4 | 2020/10/20 05:02:10 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 4 | 2020/10/20 05:02:10 | # An error report file with more information is saved as:
INFO | jvm 4 | 2020/10/20 05:02:10 | # /usr/local/bin/ignition/hs_err_pid2670.log
STATUS | wrapper | 2020/10/20 05:02:15 | Reloading Wrapper configuration...
STATUS | wrapper | 2020/10/20 05:02:15 | JVM process is gone.
STATUS | wrapper | 2020/10/20 05:02:15 | Launching a JVM...
ERROR | wrapper | 2020/10/20 05:02:15 | JVM exited while loading the application.
INFO | jvm 5 | 2020/10/20 05:02:15 | OpenJDK 64-Bit Server VM warning: INFO: os::commit_memory(0x00000000aaaa0000, 715849728, 0) failed; error='Not enough space' (errno=12)
INFO | jvm 5 | 2020/10/20 05:02:15 | #
INFO | jvm 5 | 2020/10/20 05:02:15 | # There is insufficient memory for the Java Runtime Environment to continue.
INFO | jvm 5 | 2020/10/20 05:02:15 | # Native memory allocation (mmap) failed to map 715849728 bytes for committing reserved memory.
INFO | jvm 5 | 2020/10/20 05:02:15 | # An error report file with more information is saved as:
INFO | jvm 5 | 2020/10/20 05:02:15 | # /usr/local/bin/ignition/hs_err_pid2703.log
FATAL | wrapper | 2020/10/20 05:02:16 | There were 5 failed launches in a row, each lasting less than 300 seconds. Giving up.
FATAL | wrapper | 2020/10/20 05:02:16 | There may be a configuration problem: please check the logs.
STATUS | wrapper | 2020/10/20 05:02:16 | <-- Wrapper Stopped

James.Lorenz · October 20, 2020, 5:17am

Those logs indicate that there isn’t enough free RAM on the machine to run the gateway, which is configured to use 2GB by default.

ignalbertsh · October 21, 2020, 1:45am

Thanks, now ignition is successfully installed and it showed

"Gateway started"
"http://localhost:8088"
but when I call it on my browser it still blank.

Am I missing something?

I try to search for ignition PID on "ps -ef" command and i cant found any text containing ignition

ignalbertsh · October 21, 2020, 1:52am

Here is the log files

log files

Kevin.Herron · October 21, 2020, 2:19am

Can you upload the wrapper.log file again?

ignalbertsh · October 21, 2020, 3:09am

Here it is

STATUS | wrapper | 2020/10/21 01:39:49 | --> Wrapper Started as Daemon
STATUS | wrapper | 2020/10/21 01:39:49 | Java Service Wrapper Standard Edition 64-bit 3.5.42
STATUS | wrapper | 2020/10/21 01:39:49 | Copyright (C) 1999-2020 Tanuki Software, Ltd. All Rights Reserved.
STATUS | wrapper | 2020/10/21 01:39:49 | http://wrapper.tanukisoftware.com
STATUS | wrapper | 2020/10/21 01:39:49 | Licensed to Inductive Automation for Inductive Automation
STATUS | wrapper | 2020/10/21 01:39:49 |
STATUS | wrapper | 2020/10/21 01:39:49 | Launching a JVM...
INFO | jvm 1 | 2020/10/21 01:39:50 | WrapperManager: Initializing...
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,180 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [data//logback.xml] at [file:/usr/local/bin/ignition/data/logback.xml]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,383 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,390 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [SysoutAppender]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,400 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,458 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [com.inductiveautomation.logging.SQLiteAppender]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,477 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [DB]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,707 |-INFO in ch.qos.logback.core.db.DataSourceConnectionSource@7d9e3ca5 - Driver name=SQLite JDBC
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,707 |-INFO in ch.qos.logback.core.db.DataSourceConnectionSource@7d9e3ca5 - Driver version=3.23.1
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,707 |-INFO in ch.qos.logback.core.db.DataSourceConnectionSource@7d9e3ca5 - supportsGetGeneratedKeys=true
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,787 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,791 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [SysoutAsync]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,791 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [SysoutAppender] to ch.qos.logback.classic.AsyncAppender[SysoutAsync]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,791 |-INFO in ch.qos.logback.classic.AsyncAppender[SysoutAsync] - Attaching appender named [SysoutAppender] to AsyncAppender.
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,792 |-INFO in ch.qos.logback.classic.AsyncAppender[SysoutAsync] - Setting discardingThreshold to 51
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,792 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,792 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [DBAsync]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,792 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [DB] to ch.qos.logback.classic.AsyncAppender[DBAsync]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,792 |-INFO in ch.qos.logback.classic.AsyncAppender[DBAsync] - Attaching appender named [DB] to AsyncAppender.
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,792 |-INFO in ch.qos.logback.classic.AsyncAppender[DBAsync] - Setting discardingThreshold to 51
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,793 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,793 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [SysoutAsync] to Logger[ROOT]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,793 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [DBAsync] to Logger[ROOT]
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,793 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
INFO | jvm 1 | 2020/10/21 01:39:51 | 01:39:51,794 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@5003b875 - Registering current configuration as safe fallback point
INFO | jvm 1 | 2020/10/21 01:39:51 | W [WebResourceManagerImpl ] [01:39:51]: Unable to read "gateway.metroKeystoreAlias" gateway.xml property. Assuming metro keystore alias is: metro-key
INFO | jvm 1 | 2020/10/21 01:39:52 | I [o.e.j.u.log ] [01:39:52]: Logging initialized @2526ms to org.eclipse.jetty.util.log.Slf4jLog
INFO | jvm 1 | 2020/10/21 01:39:52 | I [g.WebServerManager ] [01:39:52]: Starting setup
INFO | jvm 1 | 2020/10/21 01:39:52 | I [g.WebServerManager ] [01:39:52]: gateway.forceSecureRedirect property is not set. Defaulting to false
INFO | jvm 1 | 2020/10/21 01:39:52 | I [g.WebServerManager ] [01:39:52]: gateway.includedCipherSuites property is not set. Defaulting to
INFO | jvm 1 | 2020/10/21 01:39:52 | I [g.WebServerManager ] [01:39:52]: gateway.excludedCipherSuites property is not set. Defaulting to
INFO | jvm 1 | 2020/10/21 01:39:52 | I [g.WebServerManager ] [01:39:52]: gateway.publicAddress.autoDetect property is not set. Defaulting to true
INFO | jvm 1 | 2020/10/21 01:39:52 | I [g.WebServerManager ] [01:39:52]: gateway.publicAddress.address property is not set. Defaulting to
INFO | jvm 1 | 2020/10/21 01:39:52 | I [g.WebServerManager ] [01:39:52]: gateway.publicAddress.httpPort property is not set. Defaulting to
INFO | jvm 1 | 2020/10/21 01:39:52 | I [g.WebServerManager ] [01:39:52]: gateway.publicAddress.httpsPort property is not set. Defaulting to
INFO | jvm 1 | 2020/10/21 01:39:52 | I [g.WebServerManager ] [01:39:52]: Setup complete
INFO | jvm 1 | 2020/10/21 01:39:53 | I [Commissioning ] [01:39:52]: Commissioning State updated from commissioning to needs_commissioning
INFO | jvm 1 | 2020/10/21 01:39:53 | I [g.WebServerManager ] [01:39:53]: Starting up
INFO | jvm 1 | 2020/10/21 01:39:53 | I [o.e.j.s.Server ] [01:39:53]: jetty-9.4.24.v20191120; built: 2019-11-20T21:37:49.771Z; git: 363d5f2df3a8a28de40604320230664b9c793c16; jvm 11.0.7+10-LTS
INFO | jvm 1 | 2020/10/21 01:39:53 | I [o.e.j.s.session ] [01:39:53]: DefaultSessionIdManager workerName=node0
INFO | jvm 1 | 2020/10/21 01:39:53 | I [o.e.j.s.session ] [01:39:53]: No SessionScavenger set, using defaults
INFO | jvm 1 | 2020/10/21 01:39:53 | I [o.e.j.s.session ] [01:39:53]: node0 Scavenging every 600000ms
INFO | jvm 1 | 2020/10/21 01:39:53 | I [o.e.j.s.h.ContextHandler ] [01:39:53]: Started o.e.j.w.WebAppContext@3ef72fe8{Commissioning,/,file:///usr/local/bin/ignition/webserver/webapps/commissioning/,AVAILABLE}
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp:
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: Encountered an error running main:
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: java.io.IOException: Failed to bind to 0.0.0.0/0.0.0.0:8088
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:346)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.open(ServerConnector.java:307)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at org.eclipse.jetty.server.AbstractNetworkConnector.doStart(AbstractNetworkConnector.java:80)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.doStart(ServerConnector.java:231)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at org.eclipse.jetty.server.Server.doStart(Server.java:385)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at com.inductiveautomation.catapult.IgnitionServer.start(IgnitionServer.java:902)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at com.inductiveautomation.ignition.gateway.web.WebResourceManagerImpl.start(WebResourceManagerImpl.java:319)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at com.inductiveautomation.ignition.gateway.IgnitionGateway.start(IgnitionGateway.java:538)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at com.inductiveautomation.ignition.gateway.IgnitionGateway.main(IgnitionGateway.java:275)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at com.inductiveautomation.catapult.Catapult.main(Catapult.java:8)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/java.lang.reflect.Method.invoke(Unknown Source)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:349)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/java.lang.Thread.run(Unknown Source)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: Caused by: java.net.BindException: Address already in use
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/sun.nio.ch.Net.bind0(Native Method)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/sun.nio.ch.Net.bind(Unknown Source)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/sun.nio.ch.Net.bind(Unknown Source)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/sun.nio.ch.ServerSocketChannelImpl.bind(Unknown Source)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at java.base/sun.nio.ch.ServerSocketAdaptor.bind(Unknown Source)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:342)
INFO | jvm 1 | 2020/10/21 01:39:53 | WrapperSimpleApp Error: ... 17 more
STATUS | wrapper | 2020/10/21 01:39:56 | <-- Wrapper Stopped

Kevin.Herron · October 21, 2020, 12:09pm

Either a permissions error, or more likely, some other piece of software is already using port 8088.

ignalbertsh · October 21, 2020, 1:23pm

Okay, now the process is running I can see the ignition PID
but it still not shown anything on my browser.
here is another log showing which port is used

root@albert:~# sudo lsof -i -P -n | grep LISTEN
systemd-r 685 systemd-resolve 13u IPv4 15313 0t0 TCP 127.0.0.53:53 (LISTEN)
grafana-s 780 grafana 8u IPv6 19301 0t0 TCP *:3000 (LISTEN)
node 793 root 19u IPv4 20316 0t0 TCP *:1880 (LISTEN)
sshd 840 root 3u IPv4 18198 0t0 TCP *:22 (LISTEN)
sshd 840 root 4u IPv6 18204 0t0 TCP *:22 (LISTEN)
nginx 936 root 6u IPv4 18763 0t0 TCP *:80 (LISTEN)
nginx 936 root 7u IPv6 18764 0t0 TCP *:80 (LISTEN)
nginx 937 www-data 6u IPv4 18763 0t0 TCP *:80 (LISTEN)
nginx 937 www-data 7u IPv6 18764 0t0 TCP *:80 (LISTEN)
java 2559 albert 4u IPv4 496740 0t0 TCP 127.0.0.1:32000 (LISTEN)
java 2559 albert 105u IPv6 496946 0t0 TCP *:8088 (LISTEN)

it is stated that port 8088 uses IPv6, is it normal? how do i change it to IPv4?

Kevin.Herron · October 21, 2020, 1:28pm

It's normal for Java to default to IPv6, it should not generally be an issue.

You can force IPv4 by adding an property to the "additional parameters" section of ignition.conf:
-Djava.net.preferIPv4Stack=true

What does your wrapper.log look like now? Does it show a successful startup?

ignalbertsh · October 21, 2020, 1:38pm

This is the full wrapper log
wrapper log

Kevin.Herron · October 21, 2020, 1:42pm

Hmm. Looks okay now… you should see the commissioning page at http://localhost:8088 (or some other IP if you are not running the browser on the same server) now.

What browser are you using? Is there perhaps a firewall in the way?