I changed web server setting HTTP/HTTPS port from 8080/8043 to 80/443.
After changing the config, I restarted gateway with gwcmd --restart
.
It took too much time(restart starts from 15:34:40, and took 10min) and ended up not restarting.
I just want to know why Gateway startup is failed,
and How to reconfigure HTTP/HTTPS port back to 8080/8043 when whole thing was running well.
me@myserver:~$ gwcmd -i
No response from Gateway
me@myserver:~$ /usr/local/bin/ignition/ignition.sh start
Starting Ignition-Gateway with systemd...
Job for Ignition-Gateway.service failed because the control process exited with error code.
See "systemctl status Ignition-Gateway.service" and "journalctl -xe" for details.
Failed to start service Ignition-Gateway
Add more information and current status
me@myserver:~$ sudo systemctl status Ignition-Gateway.service
● Ignition-Gateway.service - Ignition-Gateway
Loaded: loaded (/etc/systemd/system/Ignition-Gateway.service; enabled; vendor preset: enabled)
Active: failed (Result: exit-code) since Wed 2023-09-13 16:28:00 KST; 6min ago
Process: 9567 ExecStart=/usr/local/bin/ignition/ignition.sh start sysd (code=exited, status=1/FAILURE)
9월 13 16:27:55 myserver systemd[1]: Starting Ignition-Gateway...
9월 13 16:27:56 myserver ignition.sh[9567]: Starting Ignition-Gateway...
9월 13 16:28:00 myserver ignition.sh[9567]: Waiting for Ignition-Gateway.......
9월 13 16:28:00 myserver ignition.sh[9567]: WARNING: Ignition-Gateway may have failed to start.
9월 13 16:28:00 myserver systemd[1]: Ignition-Gateway.service: Control process exited, code=exited, status=1/FAILURE
9월 13 16:28:00 myserver systemd[1]: Ignition-Gateway.service: Failed with result 'exit-code'.
9월 13 16:28:00 myserver systemd[1]: Failed to start Ignition-Gateway.
On syslog:
Sep 13 16:27:55 myserver systemd[1]: Starting Ignition-Gateway...
Sep 13 16:27:56 myserver ignition.sh[9567]: Starting Ignition-Gateway...
Sep 13 16:27:58 myserver org.gnome.Nautilus[4416]: Traceback (most recent call last):
Sep 13 16:27:58 myserver org.gnome.Nautilus[4416]: File "/usr/share/nautilus-python/extensions/clamtk-gnome.py", line 64, in get_file_items
Sep 13 16:27:58 myserver org.gnome.Nautilus[4416]: tip=_('Scan %s for threats...') % file.get_name(),
Sep 13 16:27:58 myserver org.gnome.Nautilus[4416]: TypeError: %b requires a bytes-like object, or an object that implements __bytes__, not 'str'
Sep 13 16:28:00 myserver ignition.sh[9567]: Waiting for Ignition-Gateway.......
Sep 13 16:28:00 myserver ignition.sh[9567]: WARNING: Ignition-Gateway may have failed to start.
Sep 13 16:28:00 myserver systemd[1]: Ignition-Gateway.service: Control process exited, code=exited, status=1/FAILURE
Sep 13 16:28:00 myserver systemd[1]: Ignition-Gateway.service: Failed with result 'exit-code'.
Sep 13 16:28:00 myserver systemd[1]: Failed to start Ignition-Gateway.
Lastly, this is the part of the wrapper.log
file.
I think this represents the situation immediately after the restart was made.
STATUS | wrapper | 2023/09/13 15:34:59 | on_exit trigger matched. Restarting the JVM. (Exit code: 2)
STATUS | wrapper | 2023/09/13 15:35:04 | Reloading Wrapper configuration...
STATUS | wrapper | 2023/09/13 15:35:04 | JVM process is gone.
STATUS | wrapper | 2023/09/13 15:35:04 | Launching a JVM...
INFO | jvm 2 | 2023/09/13 15:35:05 | WrapperManager: Initializing...
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,530 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [data//logback.xml] at [file:/usr/local/bin/ignition/data/logback.xml]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,598 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,601 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [SysoutAppender]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,605 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,621 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [com.inductiveautomation.logging.SQLiteAppender]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,627 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [DB]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,714 |-INFO in ch.qos.logback.core.db.DataSourceConnectionSource@7a29f573 - Driver name=SQLite JDBC
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,714 |-INFO in ch.qos.logback.core.db.DataSourceConnectionSource@7a29f573 - Driver version=3.39.2.0
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,714 |-INFO in ch.qos.logback.core.db.DataSourceConnectionSource@7a29f573 - supportsGetGeneratedKeys=true
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,720 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,722 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [SysoutAsync]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,722 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [SysoutAppender] to ch.qos.logback.classic.AsyncAppender[SysoutAsync]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,722 |-INFO in ch.qos.logback.classic.AsyncAppender[SysoutAsync] - Attaching appender named [SysoutAppender] to AsyncAppender.
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,722 |-INFO in ch.qos.logback.classic.AsyncAppender[SysoutAsync] - Setting discardingThreshold to 51
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,722 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.classic.AsyncAppender]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,723 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [DBAsync]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,723 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [DB] to ch.qos.logback.classic.AsyncAppender[DBAsync]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,723 |-INFO in ch.qos.logback.classic.AsyncAppender[DBAsync] - Attaching appender named [DB] to AsyncAppender.
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,723 |-INFO in ch.qos.logback.classic.AsyncAppender[DBAsync] - Setting discardingThreshold to 51
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,723 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,723 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [SysoutAsync] to Logger[ROOT]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,723 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [DBAsync] to Logger[ROOT]
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,723 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,724 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@66b5361b - Registering current configuration as safe fallback point
INFO | jvm 2 | 2023/09/13 15:35:05 | Scheduling logfile maintenance. Last maintenance: Thu Jan 01 09:00:00 KST 1970, events since then: 0
INFO | jvm 2 | 2023/09/13 15:35:05 | Starting logfile maintenance. Max entries: 50000, Max filesize: 104857600
INFO | jvm 2 | 2023/09/13 15:35:05 | 15:35:05,766 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@61f2b067 - Propagating INFO level on Logger[ROOT] onto the JUL framework
INFO | jvm 2 | 2023/09/13 15:35:05 | W [WebResourceManagerImpl ] [06:35:05]: Unable to read "gateway.metroKeystoreAlias" gateway.xml property. Assuming metro keystore alias is: metro-key
INFO | jvm 2 | 2023/09/13 15:35:05 | Cleaned up 2496 rows in 60 ms. Vacuum performed: false
INFO | jvm 2 | 2023/09/13 15:35:06 | I [g.WebServerManager ] [06:35:05]: Starting setup
INFO | jvm 2 | 2023/09/13 15:35:06 | I [g.WebServerManager ] [06:35:05]: Setup complete
INFO | jvm 2 | 2023/09/13 15:35:06 | I [g.WebServerManager ] [06:35:06]: Starting up
INFO | jvm 2 | 2023/09/13 15:35:06 | I [g.SslManager ] [06:35:06]: State refreshed state=SELF_SIGNED_CERTIFICATE
INFO | jvm 2 | 2023/09/13 15:35:06 | I [C.SecureRandomProvider ] [06:35:06]: Secure random seed generated in 1ms
INFO | jvm 2 | 2023/09/13 15:35:06 | I [o.e.j.s.Server ] [06:35:06]: jetty-10.0.13; built: 2022-12-07T20:13:20.134Z; git: 1c2636ea05c0ca8de1ffd6ca7f3a98ac084c766d; jvm 11.0.18+10-LTS
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp:
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: Encountered an error running main:
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: MultiException[java.io.IOException: Failed to bind to 0.0.0.0/0.0.0.0:80, java.io.IOException: Failed to bind to 0.0.0.0/0.0.0.0:443]
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.util.MultiException.ifExceptionThrow(MultiException.java:117)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.Server.doStart(Server.java:410)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:93)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at com.inductiveautomation.catapult.IgnitionServer.start(IgnitionServer.java:1158)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at com.inductiveautomation.ignition.gateway.web.WebResourceManagerImpl.start(WebResourceManagerImpl.java:351)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at com.inductiveautomation.ignition.gateway.IgnitionGateway.start(IgnitionGateway.java:578)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at com.inductiveautomation.ignition.gateway.IgnitionGateway.main(IgnitionGateway.java:300)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at com.inductiveautomation.catapult.Catapult.main(Catapult.java:8)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.lang.reflect.Method.invoke(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.tanukisoftware.wrapper.WrapperSimpleApp.run(WrapperSimpleApp.java:349)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.lang.Thread.run(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: Suppressed: java.io.IOException: Failed to bind to 0.0.0.0/0.0.0.0:443
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:344)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.open(ServerConnector.java:304)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.Server.lambda$doStart$0(Server.java:402)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ReferencePipeline$3$1.accept(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ReferencePipeline$2$1.accept(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.Spliterators$ArraySpliterator.forEachRemaining(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.AbstractPipeline.copyInto(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.AbstractPipeline.evaluate(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ReferencePipeline.forEach(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.Server.doStart(Server.java:398)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: ... 12 more
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: Caused by: java.net.SocketException: 허가 거부
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/sun.nio.ch.Net.bind0(Native Method)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/sun.nio.ch.Net.bind(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/sun.nio.ch.Net.bind(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/sun.nio.ch.ServerSocketChannelImpl.bind(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:339)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: ... 25 more
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: Caused by: java.io.IOException: Failed to bind to 0.0.0.0/0.0.0.0:80
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:344)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.open(ServerConnector.java:304)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.Server.lambda$doStart$0(Server.java:402)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ReferencePipeline$3$1.accept(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ReferencePipeline$2$1.accept(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.Spliterators$ArraySpliterator.forEachRemaining(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.AbstractPipeline.copyInto(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.AbstractPipeline.evaluate(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/java.util.stream.ReferencePipeline.forEach(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.Server.doStart(Server.java:398)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: ... 12 more
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: Caused by: java.net.SocketException: 허가 거부
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/sun.nio.ch.Net.bind0(Native Method)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/sun.nio.ch.Net.bind(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/sun.nio.ch.Net.bind(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at java.base/sun.nio.ch.ServerSocketChannelImpl.bind(Unknown Source)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: at org.eclipse.jetty.server.ServerConnector.openAcceptChannel(ServerConnector.java:339)
INFO | jvm 2 | 2023/09/13 15:35:06 | WrapperSimpleApp Error: ... 25 more
STATUS | wrapper | 2023/09/13 15:35:08 | <-- Wrapper Stopped
STATUS | wrapper | 2023/09/13 15:56:24 | --> Wrapper Started as Daemon