Fresh install of tModLoader for a terraria server. Using all default settings, pulling from Github. The instance is running, but after ‘updating’ the server itself doesn’t start. Manually starting it begins the update process, but it doesn’t actually start.
OS Linux
Platform Ubuntu 22.04.4
System Type x86_64
CPU Model QEMU Virtual CPU version 2.5+
CPU Layout 1S/28C/28T
Installed RAM 24018
Virtualization QEMU_KVM
Module ADSModule
Module Application Application Deployment
Loaded Plugins FileManagerPlugin, EmailSenderPlugin, WebRequestPlugin, LocalFileBackupPlugin, CommonCorePlugin
Application Name AMP
Application Version 2.5.0.14
Codename Callisto
Tools Version 2.5.0.14
Steps to reproduce:
1 Create Instance
2 Update Instance
3 update Server
4 Start Server
Actions taken to resolve so far:
Reactivated all licenses
Verfied that AMP and all instances have been upgraded to latest
Deleted deployment template folder, fetched latest. I am only using CubeCoders templates.
Ensured that Dotnet is 8.0.4
Rebooted server after instance deployment is finished.
Verified nothing else is using it's port, but AMP seems to not be opening it. (7779 - Both)
Verified 7779 (Both) is allowed in firewall.
Could send / receive traffic across my tunnel using that port.
Log listed
[01:56:01] [Core Info/1] : Starting AMP version 2.5.0.14 (Callisto), built 14/06/2024 03:45
[01:56:01] [Core Info/1] : Stream: Mainline / Release - built by CUBECODERS/buildbot on CCL-DEV
[01:56:01] [Core Debug/1] : Loading locale data for xx from xx.json...
[01:56:01] [Core Info/1] : Running in a Docker environment.
[01:56:01] [Core Info/1] : OS: Linux / x86_64
[01:56:01] [Core Info/1] : CPU: QEMU Virtual CPU version 2.5+ (28C/28T)
[01:56:01] [Core Info/1] : RAM: 24018MB
[01:56:01] [Core Info/1] : AMP Instance ID: 337a5a6c-ea0c-4048-9ad6-8f04fd2f2918
[01:56:01] [Core Debug/1] : Configuring licencing, crypto and webserver...
[01:56:02] [Licencing Debug/1] : No primary IP found.
[01:56:02] [Config Debug/1] : Setting up secure value store with machine hash: YnItNjhiZGM3Y2QyOTk1MDI0MjE1NTBDMTYz
[01:56:02] [Core Debug/1] : Configuring shared components...
[01:56:02] [Core Debug/1] : Using remote login server http://localhost:8080/
[01:56:02] [Core Debug/1] : Configuring application module...
[01:56:02] [SignatureVerification Debug/1] : Performing signature verification for GenericModule...
[01:56:02] [SignatureVerification Debug/1] : Performing signature verification for steamcmdplugin...
[01:56:02] [SignatureVerification Debug/1] : Performing signature verification for RCONPlugin...
[01:56:02] [Loader Info/1] : Loaded GenericModule version 1.0.0.0 by CubeCoders Limited
[01:56:02] [Core Debug/1] : Configuring scheduler...
[01:56:02] [Core Info/1] : Metrics publishing is enabled at udp://localhost:12820.
[01:56:02] [SignatureVerification Debug/1] : Performing signature verification for FileManagerPlugin...
[01:56:02] [Loader Info/1] : Loaded FileManagerPlugin by CubeCoders Limited
[01:56:02] [SignatureVerification Debug/1] : Performing signature verification for EmailSenderPlugin...
[01:56:02] [Loader Info/1] : Loaded EmailSenderPlugin by CubeCoders Limited
[01:56:02] [SignatureVerification Debug/1] : Performing signature verification for WebRequestPlugin...
[01:56:02] [Loader Info/1] : Loaded WebRequestPlugin by CubeCoders Limited
[01:56:02] [SignatureVerification Debug/1] : Performing signature verification for LocalFileBackupPlugin...
[01:56:02] [FileBackup Debug/1] : Read manifests for 0 backups.
[01:56:02] [Loader Info/1] : Loaded LocalFileBackupPlugin by CubeCoders Limited
[01:56:02] [SignatureVerification Debug/1] : Performing signature verification for CommonCorePlugin...
[01:56:02] [Loader Info/1] : Loaded CommonCorePlugin by CubeCoders Limited
[01:56:02] [Loader Info/1] : GenericModule requests dependency steamcmdplugin...
[01:56:02] [Loader Info/1] : Loaded steamcmdplugin by CubeCoders Limited
[01:56:02] [Loader Info/1] : GenericModule requests dependency RCONPlugin...
[01:56:02] [Loader Info/1] : Loaded RCONPlugin by CubeCoders Limited
[01:56:02] [Core Debug/1] : Checking settings...
[01:56:02] [Core Info/1] : Licence Present: AMP Advanced Edition
[01:56:03] [FileManager Notice/1] : Using keypair with fingerprint dwevQCtWsZSP6K1V9vDOX959lKfq2RqBX4JA112Vg7Q=
[01:56:03] [FileManager Info/1] : SFTP Server started on 0.0.0.0:2227
[01:56:03] [Webserver Debug/1] : Using webroot: /AMP/WebRoot
[01:56:03] [Webserver Info/1] : Websockets are enabled.
[01:56:03] [API Debug/1] : Building setting specification cache...
[01:56:03] [API Debug/1] : Setting spec cache built, 153 items added.
[01:56:03] [Logger Info/13] : RouterTimer@10Hz with 2 jobs started
[01:56:03] [Webserver Info/1] : Webserver started on http://0.0.0.0:8084
[01:56:03] [Scheduler Debug/1] : Scheduler timer will start in 56683ms.
[01:56:03] [Core Info/1] : Checking for AMP updates...
[01:56:03] [Core Info/1] : Startup mode is StartApplication.
[01:56:03] [Generic Info/1] : Specified executable '/AMP/tModLoader/serverfiles/dotnet/dotnet does not exist. Updating application...
[01:56:03] [Core Debug/1] : Startup Complete.
[01:56:03] [Core Debug/5] : Application state changed from Stopped to Updating
[01:56:03] [Generic Debug/5] : Running update/pre-start stage Config Template Download (FetchURL https://github.com/CubeCoders/AMPTemplates/raw/main/tmodloader14serverconfig.txt )
[01:56:03] [Generic Info/5] : Skipping download - target already exists (./tModLoader/serverfiles/tmodloader14serverconfig.txt)
[01:56:03] [Generic Debug/5] : Update stage Config Template Download completed with status True.
[01:56:03] [Generic Debug/5] : Skipping update stage SteamCMD tModLoader because condition Source is not met.
[01:56:03] [Generic Debug/5] : Update stage SteamCMD tModLoader completed with status True.
[01:56:03] [Generic Debug/5] : Running update/pre-start stage GitHub tModLoader (GithubRelease tModLoader.zip tModLoader/tModLoader )
[01:56:03] [Generic Debug/5] : Fetching repo metadata from https://api.github.com/repos/tModLoader/tModLoader/releases/latest...
[01:56:03] [Generic Debug/15] : Running update/pre-start stage (FetchURL https://github.com/tModLoader/tModLoader/releases/download/v2024.05.3.0/tModLoader.zip )
[01:56:03] [Core Debug/15] : Downloading https://github.com/tModLoader/tModLoader/releases/download/v2024.05.3.0/tModLoader.zip, saving to ./tModLoader/serverfiles/tModLoader.zip...
[01:56:03] [Core Info/9] : AMP is up to date.
[01:56:07] [Core Debug/9] : File already exists: ./tModLoader/serverfiles/tModLoader.zip, deleting...
[01:56:07] [Core Debug/9] : Moving /tmp/3m3o8eqq.hnk to ./tModLoader/serverfiles/tModLoader.zip...
[01:56:07] [Generic Info/9] : Extracting /AMP/tModLoader/serverfiles/tModLoader.zip to /AMP/tModLoader/serverfiles...
[01:56:12] [RunningTasksManager Debug/16] : Task Downloading tModLoader () ended: Finished
[01:56:12] [Generic Debug/16] : Update stage GitHub tModLoader completed with status True.
[01:56:12] [Generic Debug/16] : Running update/pre-start stage Create Dotnet Directory (CreateDirectory /AMP/tModLoader/serverfiles/dotnet )
[01:56:12] [Generic Debug/16] : Update stage Create Dotnet Directory completed with status True.
[01:56:12] [Generic Debug/16] : Running update/pre-start stage Dotnet download Linux (FetchURL https://dotnetcli.azureedge.net/dotnet/Runtime/8.0.4/dotnet-runtime-8.0.4-linux-x64.tar.gz )
[01:56:12] [Core Debug/16] : Downloading https://dotnetcli.azureedge.net/dotnet/Runtime/8.0.4/dotnet-runtime-8.0.4-linux-x64.tar.gz, saving to /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz...
[01:57:51] [Core Debug/5] : Login request from 127.0.0.1 for jimmitang
[01:57:51] [Core Activity/5] : Authentication attempt for user jimmitang from 127.0.0.1
[01:57:51] [Core Debug/5] : Logging in via remote auth server http://localhost:8080/...
[01:57:52] [Core Activity/10] : Authentication success
[01:57:52] [API Debug/10] : Creating new session for jimmitang at 127.0.0.1 (AMP_ADS_REDIR/10) API Login
[01:57:52] [API Debug/10] : Total sessions count: 0
[01:57:52] [API Debug/10] : Timeout: 15
[01:57:52] [API Debug/10] : Login success from 127.0.0.1 assigned session ID d3080264-a8ae-49ff-a232-9e562901ce99
[01:57:52] [RunningTasksManager Debug/10] : Task Downloading tModLoader () failed: The operation has timed out.
[01:57:52] [Core Debug/10] : File already exists: /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz, deleting...
[01:57:52] [Core Debug/10] : Moving /tmp/jhgg7pkn.psv to /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz...
[01:57:52] [Generic Info/10] : Extracting /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz to /AMP/tModLoader/serverfiles/dotnet...
[01:57:52] [Core Debug/10] : Running command line: "/usr/bin/tar zxf "/AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz"" from "/AMP/tModLoader/serverfiles/dotnet"
[01:57:52] [RunningTasksManager Debug/10] : Task Downloading tModLoader () failed: The operation has timed out.
[01:57:52] [RunningTasksManager Debug/10] : Task Downloading tModLoader () ended: Finished
[01:57:52] [Generic Debug/10] : Update stage Dotnet download Linux completed with status True.
[01:57:52] [RunningTasksManager Debug/10] : Task Running Update Tasks () ended: Finished
[01:57:52] [Core Debug/10] : Application state changed from Updating to Stopped
[01:57:52] [Generic Info/10] : Merging config file ./tModLoader/serverfiles/tmodloader14serverconfig.txt (KVP format) using Unicode (UTF-8) encoding.
[01:57:52] [Generic Debug/10] : Finished merging ./tModLoader/serverfiles/tmodloader14serverconfig.txt
[01:57:52] [Generic Info/10] : Specified executable '/AMP/tModLoader/serverfiles/dotnet/dotnet does not exist. Updating application...
[01:57:52] [Core Debug/10] : Application state changed from Stopped to Updating
[01:57:52] [Generic Debug/10] : Running update/pre-start stage Config Template Download (FetchURL https://github.com/CubeCoders/AMPTemplates/raw/main/tmodloader14serverconfig.txt )
[01:57:52] [Generic Info/10] : Skipping download - target already exists (./tModLoader/serverfiles/tmodloader14serverconfig.txt)
[01:57:52] [Generic Debug/10] : Update stage Config Template Download completed with status True.
[01:57:52] [Generic Debug/10] : Skipping update stage SteamCMD tModLoader because condition Source is not met.
[01:57:52] [Generic Debug/10] : Update stage SteamCMD tModLoader completed with status True.
[01:57:52] [Generic Debug/10] : Running update/pre-start stage GitHub tModLoader (GithubRelease tModLoader.zip tModLoader/tModLoader )
[01:57:52] [Generic Debug/10] : Fetching repo metadata from https://api.github.com/repos/tModLoader/tModLoader/releases/latest...
[01:57:53] [Generic Debug/7] : Running update/pre-start stage (FetchURL https://github.com/tModLoader/tModLoader/releases/download/v2024.05.3.0/tModLoader.zip )
[01:57:53] [Core Debug/7] : Downloading https://github.com/tModLoader/tModLoader/releases/download/v2024.05.3.0/tModLoader.zip, saving to ./tModLoader/serverfiles/tModLoader.zip...
[01:57:56] [Core Debug/5] : File already exists: ./tModLoader/serverfiles/tModLoader.zip, deleting...
[01:57:56] [Core Debug/5] : Moving /tmp/v1ym1xcz.zzl to ./tModLoader/serverfiles/tModLoader.zip...
[01:57:56] [Generic Info/5] : Extracting /AMP/tModLoader/serverfiles/tModLoader.zip to /AMP/tModLoader/serverfiles...
[01:58:02] [RunningTasksManager Debug/5] : Task Downloading tModLoader () ended: Finished
[01:58:02] [Generic Debug/5] : Update stage GitHub tModLoader completed with status True.
[01:58:02] [Generic Debug/5] : Running update/pre-start stage Create Dotnet Directory (CreateDirectory /AMP/tModLoader/serverfiles/dotnet )
[01:58:02] [Generic Debug/5] : Update stage Create Dotnet Directory completed with status True.
[01:58:02] [Generic Debug/5] : Running update/pre-start stage Dotnet download Linux (FetchURL https://dotnetcli.azureedge.net/dotnet/Runtime/8.0.4/dotnet-runtime-8.0.4-linux-x64.tar.gz )
[01:58:02] [Core Debug/5] : Downloading https://dotnetcli.azureedge.net/dotnet/Runtime/8.0.4/dotnet-runtime-8.0.4-linux-x64.tar.gz, saving to /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz...
[01:59:42] [RunningTasksManager Debug/18] : Task Downloading tModLoader () failed: The operation has timed out.
[01:59:42] [Core Debug/18] : File already exists: /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz, deleting...
[01:59:42] [Core Debug/18] : Moving /tmp/d27ym9ga.mz3 to /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz...
[01:59:42] [Generic Info/18] : Extracting /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz to /AMP/tModLoader/serverfiles/dotnet...
[01:59:42] [Core Debug/18] : Running command line: "/usr/bin/tar zxf "/AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz"" from "/AMP/tModLoader/serverfiles/dotnet"
[01:59:42] [RunningTasksManager Debug/18] : Task Downloading tModLoader () failed: The operation has timed out.
[01:59:42] [RunningTasksManager Debug/18] : Task Downloading tModLoader () ended: Finished
[01:59:42] [Generic Debug/18] : Update stage Dotnet download Linux completed with status True.
[01:59:42] [RunningTasksManager Debug/18] : Task Running Update Tasks () ended: Finished
[01:59:42] [Core Debug/18] : Application state changed from Updating to Stopped
[01:59:42] [Generic Info/18] : Merging config file ./tModLoader/serverfiles/tmodloader14serverconfig.txt (KVP format) using Unicode (UTF-8) encoding.
[01:59:42] [Generic Debug/18] : Finished merging ./tModLoader/serverfiles/tmodloader14serverconfig.txt
[02:04:18] [Core Debug/4] : Login request from 127.0.0.1 for jimmitang
[02:04:18] [Core Activity/4] : Authentication attempt for user jimmitang from 127.0.0.1
[02:04:18] [Core Debug/4] : Logging in via remote auth server http://localhost:8080/...
[02:04:19] [Core Activity/5] : Authentication success
[02:04:19] [API Debug/5] : Creating new session for jimmitang at 127.0.0.1 (AMP_ADS_REDIR/10) API Login
[02:04:19] [API Debug/5] : Total sessions count: 1
[02:04:19] [API Debug/5] : Timeout: 15
[02:04:19] [API Debug/5] : Login success from 127.0.0.1 assigned session ID b10ae839-78f1-4009-a809-01f9d29b41d6
[02:04:22] [API:jimmitang Activity/27] : Updating the application.
[02:04:22] [Core:jimmitang Debug/9] : Application state changed from Stopped to Updating
[02:04:22] [Generic:jimmitang Debug/9] : Running update/pre-start stage Config Template Download (FetchURL https://github.com/CubeCoders/AMPTemplates/raw/main/tmodloader14serverconfig.txt )
[02:04:22] [Generic:jimmitang Info/9] : Skipping download - target already exists (./tModLoader/serverfiles/tmodloader14serverconfig.txt)
[02:04:22] [Generic:jimmitang Debug/9] : Update stage Config Template Download completed with status True.
[02:04:22] [Generic:jimmitang Debug/9] : Skipping update stage SteamCMD tModLoader because condition Source is not met.
[02:04:22] [Generic:jimmitang Debug/9] : Update stage SteamCMD tModLoader completed with status True.
[02:04:22] [Generic:jimmitang Debug/9] : Running update/pre-start stage GitHub tModLoader (GithubRelease tModLoader.zip tModLoader/tModLoader )
[02:04:22] [Generic:jimmitang Debug/9] : Fetching repo metadata from https://api.github.com/repos/tModLoader/tModLoader/releases/latest...
[02:04:22] [Generic:jimmitang Debug/18] : Running update/pre-start stage (FetchURL https://github.com/tModLoader/tModLoader/releases/download/v2024.05.3.0/tModLoader.zip )
[02:04:22] [Core:jimmitang Debug/18] : Downloading https://github.com/tModLoader/tModLoader/releases/download/v2024.05.3.0/tModLoader.zip, saving to ./tModLoader/serverfiles/tModLoader.zip...
[02:04:26] [Core:jimmitang Debug/7] : File already exists: ./tModLoader/serverfiles/tModLoader.zip, deleting...
[02:04:26] [Core:jimmitang Debug/7] : Moving /tmp/swvdazle.sbs to ./tModLoader/serverfiles/tModLoader.zip...
[02:04:26] [Generic:jimmitang Info/7] : Extracting /AMP/tModLoader/serverfiles/tModLoader.zip to /AMP/tModLoader/serverfiles...
[02:04:32] [RunningTasksManager:jimmitang Debug/7] : Task Downloading tModLoader () ended: Finished
[02:04:32] [Generic:jimmitang Debug/7] : Update stage GitHub tModLoader completed with status True.
[02:04:32] [Generic:jimmitang Debug/7] : Running update/pre-start stage Create Dotnet Directory (CreateDirectory /AMP/tModLoader/serverfiles/dotnet )
[02:04:32] [Generic:jimmitang Debug/7] : Update stage Create Dotnet Directory completed with status True.
[02:04:32] [Generic:jimmitang Debug/7] : Running update/pre-start stage Dotnet download Linux (FetchURL https://dotnetcli.azureedge.net/dotnet/Runtime/8.0.4/dotnet-runtime-8.0.4-linux-x64.tar.gz )
[02:04:32] [Core:jimmitang Debug/7] : Downloading https://dotnetcli.azureedge.net/dotnet/Runtime/8.0.4/dotnet-runtime-8.0.4-linux-x64.tar.gz, saving to /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz...
[02:04:51] [Core Debug/27] : Login request from 127.0.0.1 for jimmitang
[02:04:51] [Core Activity/27] : Authentication attempt for user jimmitang from 127.0.0.1
[02:04:51] [Core Debug/27] : Logging in via remote auth server http://localhost:8080/...
[02:04:51] [Core Activity/7] : Authentication success
[02:04:51] [API Debug/7] : Creating new session for jimmitang at 127.0.0.1 (AMP_ADS_REDIR/10) API Login
[02:04:51] [API Debug/7] : Total sessions count: 2
[02:04:51] [API Debug/7] : Timeout: 15
[02:04:51] [API Debug/7] : Login success from 127.0.0.1 assigned session ID e620e67b-af2f-436e-85c2-b902d08d86a2
[02:05:51] [Core Debug/16] : Login request from 127.0.0.1 for jimmitang
[02:05:51] [Core Activity/16] : Authentication attempt for user jimmitang from 127.0.0.1
[02:05:51] [Core Debug/16] : Logging in via remote auth server http://localhost:8080/...
[02:05:52] [Core Activity/27] : Authentication success
[02:05:52] [API Debug/27] : Creating new session for jimmitang at 127.0.0.1 (AMP_ADS_REDIR/10) API Login
[02:05:52] [API Debug/27] : Total sessions count: 3
[02:05:52] [API Debug/27] : Timeout: 15
[02:05:52] [API Debug/27] : Login success from 127.0.0.1 assigned session ID 29788417-0844-4368-b671-bbeaf1843b12
[02:06:12] [RunningTasksManager:jimmitang Debug/26] : Task Downloading tModLoader () failed: The operation has timed out.
[02:06:12] [Core:jimmitang Debug/26] : File already exists: /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz, deleting...
[02:06:12] [Core:jimmitang Debug/26] : Moving /tmp/8uev8cb3.nwn to /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz...
[02:06:12] [Generic:jimmitang Info/26] : Extracting /AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz to /AMP/tModLoader/serverfiles/dotnet...
[02:06:12] [Core:jimmitang Debug/26] : Running command line: "/usr/bin/tar zxf "/AMP/tModLoader/serverfiles/dotnet/dotnet-runtime-8.0.4-linux-x64.tar.gz"" from "/AMP/tModLoader/serverfiles/dotnet"
[02:06:12] [RunningTasksManager:jimmitang Debug/26] : Task Downloading tModLoader () failed: The operation has timed out.
[02:06:12] [RunningTasksManager:jimmitang Debug/26] : Task Downloading tModLoader () ended: Finished
[02:06:12] [Generic:jimmitang Debug/26] : Update stage Dotnet download Linux completed with status True.
[02:06:12] [RunningTasksManager:jimmitang Debug/26] : Task Running Update Tasks () ended: Finished
[02:06:12] [Core:jimmitang Debug/26] : Application state changed from Updating to Stopped
[02:06:12] [Generic:jimmitang Info/26] : Merging config file ./tModLoader/serverfiles/tmodloader14serverconfig.txt (KVP format) using Unicode (UTF-8) encoding.
[02:06:12] [Generic:jimmitang Debug/26] : Finished merging ./tModLoader/serverfiles/tmodloader14serverconfig.txt