Startup Issue with Minecraft - Instance turning off over night and needing a manual start

System Information

Field Value
Operating System Linux - Debian GNU/Linux 12 on x86_64
Product AMP ‘Callisto’ v2.5.1.0 (Mainline)
Virtualization Docker
Application Minecraft
Module MinecraftModule
Running in Container Yes
Current State Ready

Problem Description

Issue

Hello there, first of all I would like to warn that I’m a novice when it comes to linux/debian and so I’m not very knowledgeable when it comes to their command line.

Over the last couple of days my instances (minecraft in particular) seem to be turning off over night after a backup has been taken (this seems to be successful).

Looking at the logs the last thing each day is AMP checking for updates and happily says its fine. The next one only starts when I’m manually turning on the instance after I’ve finished work (anywhere between 8-12 hours later)

As far as I know the last thing I did was to setup a manual reverse proxy using the instructions: Setting up secure HTTP (HTTPS) with AMP with advice from @Daniel (sorry for the ping if there is one) on where to pop it within plesk which seems to be working fine.

I’m a little confused at the moment and would like some advice if possible before I do anything else and break more.

Reproduction Steps

  • Server creates a backup successfully
  • Instance turns off (sometime during the night)
  • Manually start the instance several hours later upon noticing it has turned off

@CubeCoders-Bot could you help this user take a look at their Minecraft logs (They’ll be able to find these either via the File Manager or AMPs own logs should contain a copy of the data) and see if there’s anything obvious causing it to crash. Possibly an OOM situation given that it’s after a backup.

Alright, Kelvin, let’s dive into those Minecraft logs and see why your instance is taking a nightly nap. :sleeping: Check out the logs either via AMP’s File Manager or AMP’s own logs. Post the relevant log entries here as text, and we can dig in. :scroll:


:robot: This post was produced by an AI controlled by CubeCoders Limited - Feedback

Backup made on 22nd

[22:31:22] [Server thread/INFO]: Crek has made the advancement [Inner Arts]
[22:33:54] [Server thread/INFO]: Crek has completed the challenge [One Step Layered]
[22:39:34] [Server thread/INFO]: spotnick200 lost connection: Disconnected
[22:39:34] [Server thread/INFO]: spotnick200 left the game
[22:51:33] [Server thread/INFO]: jason7766 lost connection: Disconnected
[22:51:33] [Server thread/INFO]: jason7766 left the game
[22:57:00] [Server thread/INFO]: Couldn't submit crafting job for 1xallthecompressed:iron_block_5x: NO_SUITABLE_CPU_FOUND [Detail: UnsuitableCpus[offline=0, busy=5, tooSmall=2, excluded=1]]
[23:00:00] [FileBackup Activity/665] : Creating Backup: Scheduled Backup
[23:00:00] [Server thread/INFO]: Saving the game (this may take a moment!)
[23:00:00] [Server thread/INFO]: Saved the game
[23:00:00] [Server thread/INFO]: Automatic saving is now disabled
[23:00:22] [Server thread/INFO]: Automatic saving is now enabled
[23:03:55] [Server thread/INFO]: Crek12 lost connection: Disconnected
[23:03:55] [Server thread/INFO]: Crek left the game

Overnight into 23rd

[00:00:00] [Logger Info/869]      : Rollover from previous log file: AMP_Logs/AMPLOG 2024-07-22 00-00-00.log
[02:43:00] [Core Info/768]        : Checking for AMP updates...
[02:43:00] [Core Info/757]        : AMP is up to date.

8 hours later

[08:25:41] [Core Info/1]          : Starting AMP version 2.5.1.0 (Callisto), built 06/07/2024 22:13
[08:25:41] [Core Info/1]          : Stream: Mainline / Release - built by CUBECODERS/buildbot on CCL-DEV
[08:25:41] [Core Info/1]          : Running in a Docker environment.
[08:25:41] [Core Info/1]          : OS: Linux / x86_64
[08:25:41] [Core Info/1]          : CPU: Intel(R) Core(TM) i9-9900K CPU @ 3.60GHz (8C/16T)
[08:25:41] [Core Info/1]          : RAM: 32768MB
[08:25:41] [Core Info/1]          : AMP Instance ID: af83a8c3-5e8e-47ae-9e48-0d2da0c396cc
[08:25:41] [Loader Info/1]        : Loaded MinecraftModule version 1.0.0.3 by CubeCoders Limited
[08:25:41] [Core Info/1]          : Metrics publishing is enabled at udp://localhost:12820.
[08:25:41] [Loader Info/1]        : Loaded FileManagerPlugin by CubeCoders Limited
[08:25:41] [Loader Info/1]        : Loaded EmailSenderPlugin by CubeCoders Limited
[08:25:41] [Loader Info/1]        : Loaded WebRequestPlugin by CubeCoders Limited
[08:25:41] [Loader Info/1]        : Loaded LocalFileBackupPlugin by CubeCoders Limited
[08:25:41] [Loader Info/1]        : Loaded CommonCorePlugin by CubeCoders Limited
[08:25:41] [Loader Info/1]        : Loaded AnalyticsPlugin by CubeCoders Limited
[08:25:41] [Core Info/1]          : Licence Present: AMP Advanced Edition - Lifetime Licence
[08:25:41] [FileManager Notice/1] : Using keypair with fingerprint RFhNOoomg11gWBGs0+kOCJt940ofRnRrW44nVJHIK/Q=
[08:25:41] [FileManager Info/1]   : SFTP Server started on 0.0.0.0:2224
[08:25:41] [Webserver Info/1]     : Websockets are enabled.
[08:25:41] [Webserver Info/1]     : Webserver started on http://127.0.0.1:8081
[08:25:41] [Logger Info/20]       : RouterTimer@10Hz with 2 jobs started
[08:25:41] [Core Info/1]          : Checking for AMP updates...
[08:25:42] [Core Info/1]          : Startup mode is StartApplication.
[08:25:42] [Minecraft Info/1]     : Java located at /usr/lib/jvm/temurin-21-jdk-amd64/bin/java
[08:25:42] [Minecraft Error/1]    : Process configuration failed. AMP wasn't able to query the Forge version list. Please try again later.
[08:25:42] [Core Info/14]         : AMP is up to date.
[08:25:42] [Minecraft Info/13]    : Modpack cache is up-to-date.
[08:25:42] [Minecraft Warning/17] : Unable to get Bedrock version data from https://www.minecraft.net/en-us/download/server/bedrock: Match not found.
[08:25:42] [Minecraft Info/17]    : Trying first Bedrock info fallback...
[08:25:47] [Minecraft Warning/6]  : Unable to get first fallback Bedrock version data from https://www.minecraft.net/en-us/download/server/bedrock: Match not found.
[08:25:47] [Minecraft Info/6]     : Trying second Bedrock info fallback...
[08:25:48] [Minecraft Info/13]    : Latest Bedrock version: 1.21.3.01
[08:26:05] [Core Activity/15]     : Authentication attempt for user Kgb-Admin from 127.0.0.1
[08:26:06] [Core Activity/13]     : Authentication success
[08:26:48] [Core Activity/13]     : Authentication attempt for user Kgb-Admin from 127.0.0.1
[08:26:48] [Core Activity/8]      : Authentication success
[08:26:48] [Core Activity/17]     : Authentication attempt for user Kgb-Admin from 127.0.0.1
[08:26:49] [Core Activity/6]      : Authentication success
[08:26:55] [API:Kgb-Admin Activity/17] : Starting the application.

These are from the logs within the minecraft instance, is that the right place or should I be looking within ADS?

Sweet, these logs are super helpful! :+1:

From what I can see, there’s no clear indication of an Out Of Memory (OOM) issue, but it’s still suspect, given it happens after backups. Let’s check a couple of things:

  1. Memory Usage: Make sure your Minecraft instance has enough memory allocated. You can do this via AMP’s web interface. Use the search box to find “Java and Memory”, and check the Java Memory settings.

  2. AMP Logs: Also, check the ADS logs as these might have more context on why the instance is shutting down.

Post any suspicious log entries you find from the ADS logs, and we’ll take a deeper look! :smiley:


:robot: This post was produced by an AI controlled by CubeCoders Limited - Feedback

It looks like the issue is to do with AMPs failure to query Forge version data. Is this a forge based server @Kgbuk ? Turning on Debug mode might help here, you might actually have a connectivity issue.

Alright, let’s follow Mike’s suggestion and turn on Debug mode to see more detailed logs.

Do this by navigating to the AMP’s web interface, using the search box to find and enable “Debugging”. Then, reproduce the issue to capture detailed logs.

Once you have the debug logs, post the relevant sections here, and we’ll get a clearer picture! :mag:


:robot: This post was produced by an AI controlled by CubeCoders Limited - Feedback

When double checking the Java and Memory settings the Memory Limit (MB is set to 32768 and the Memory pre-allocation (MB) is set to the default (256)

ADS Logs:
22nd

[17:48:39] [ADS:Kgb-Admin Activity/37] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[17:48:39] [Auth:Kgb-Admin Activity/37] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[21:23:20] [ADS:Kgb-Admin Activity/69] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[21:23:20] [Auth:Kgb-Admin Activity/69] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[21:23:38] [ADS:Kgb-Admin Activity/302] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[21:23:38] [Auth:Kgb-Admin Activity/302] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[21:23:38] [ADS:Kgb-Admin Activity/308] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[21:23:38] [Auth:Kgb-Admin Activity/308] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[22:52:00] [Core Info/70]         : Checking for AMP updates...
[22:52:00] [Core Info/401]        : AMP is up to date.

23rd:

[00:00:00] [Logger Info/69]       : Rollover from previous log file: AMP_Logs/AMPLOG 2024-07-22 17-15-35.log
[04:52:00] [Core Info/305]        : Checking for AMP updates...
[04:52:00] [Core Info/750]        : AMP is up to date.
[08:25:40] [InstanceManager:Kgb-Admin Info/982] : dba6df94e24824f1bea1544752ce48a38c972224d25b45d28d7a45323ebf7694
[08:26:02] [ADS:Kgb-Admin Activity/986] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[08:26:02] [Auth:Kgb-Admin Activity/986] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[08:26:47] [ADS:Kgb-Admin Activity/995] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[08:26:47] [Auth:Kgb-Admin Activity/995] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[08:26:48] [ADS:Kgb-Admin Activity/914] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[08:26:48] [Auth:Kgb-Admin Activity/914] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[10:52:00] [Core Info/1027]       : Checking for AMP updates...
[10:52:00] [Core Info/1159]       : AMP is up to date.
[12:02:35] [ADS:Kgb-Admin Activity/1238] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:02:35] [Auth:Kgb-Admin Activity/1238] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:02:36] [ADS:Kgb-Admin Activity/1238] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:02:36] [Auth:Kgb-Admin Activity/1238] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:07:23] [ADS:Kgb-Admin Activity/1031] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:07:23] [Auth:Kgb-Admin Activity/1031] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:17:29] [ADS:Kgb-Admin Activity/1236] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:17:29] [Auth:Kgb-Admin Activity/1236] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:19:25] [InstanceManager:Kgb-Admin Info/1256] : c68d18f38872fa1ee34a3b7921bf5ffe7087e3f6f4bef699ff8a62726cc4a233
[12:19:46] [ADS:Kgb-Admin Activity/1256] : Managed remote instance S20R-7DaystoDie-Server101 at http://127.0.0.1:8083/
[12:19:46] [Auth:Kgb-Admin Activity/1256] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:21:26] [ADS:Kgb-Admin Activity/1262] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:21:26] [Auth:Kgb-Admin Activity/1262] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:03:21] [ADS:Kgb-Admin Activity/1230] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:03:21] [Auth:Kgb-Admin Activity/1230] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:15:00] [ADS:Kgb-Admin Activity/1230] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:15:00] [Auth:Kgb-Admin Activity/1230] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:15:00] [ADS:Kgb-Admin Activity/1242] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:15:00] [Auth:Kgb-Admin Activity/1242] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:15:12] [ADS:Kgb-Admin Activity/1242] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:15:12] [Auth:Kgb-Admin Activity/1242] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:15:21] [ADS:Kgb-Admin Activity/1314] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:15:21] [Auth:Kgb-Admin Activity/1314] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:15:29] [ADS:Kgb-Admin Activity/1317] : Managed remote instance S20R-7DaystoDie-Server101 at http://127.0.0.1:8083/
[13:15:29] [Auth:Kgb-Admin Activity/1317] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:31:49] [ADS:Kgb-Admin Activity/1348] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:31:49] [Auth:Kgb-Admin Activity/1348] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[16:52:00] [Core Info/1594]       : Checking for AMP updates...
[16:52:00] [Core Info/1602]       : AMP is up to date.
[22:52:00] [Core Info/1738]       : Checking for AMP updates...
[22:52:00] [Core Info/1752]       : AMP is up to date.

24th

[00:00:00] [Logger Info/1738]     : Rollover from previous log file: AMP_Logs/AMPLOG 2024-07-23 00-00-00.log
[04:52:00] [Core Info/1998]       : Checking for AMP updates...
[04:52:00] [Core Info/1699]       : AMP is up to date.
[10:52:00] [Core Info/2343]       : Checking for AMP updates...
[10:52:00] [Core Info/1997]       : AMP is up to date.
[12:39:27] [InstanceManager:Kgb-Admin Info/1997] : 34c6d293af333b8ef8acc9dfe16a2be80a45e787d07c7b9ee47a4a645502eefe
[12:39:54] [ADS:Kgb-Admin Activity/2813] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:39:54] [Auth:Kgb-Admin Activity/2813] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:40:30] [ADS:Kgb-Admin Activity/2804] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:40:30] [Auth:Kgb-Admin Activity/2804] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:41:01] [ADS:Kgb-Admin Activity/1997] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:41:01] [Auth:Kgb-Admin Activity/1997] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:42:06] [Core:Kgb-Admin Warning/2832] : Slow method invocation: Servers took 3023ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2832] : Slow response: ADSModule.Servers took 3024ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2831] : Slow method invocation: Servers took 6060ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2831] : Slow response: ADSModule.Servers took 6061ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2828] : Slow method invocation: Servers took 5033ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2828] : Slow response: ADSModule.Servers took 5034ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2832] : Slow method invocation: Servers took 6068ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2832] : Slow response: ADSModule.Servers took 6068ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2828] : Slow method invocation: Servers took 4027ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2828] : Slow response: ADSModule.Servers took 4027ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2832] : Slow method invocation: Servers took 2035ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2832] : Slow response: ADSModule.Servers took 2035ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2832] : Slow method invocation: Servers took 6084ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2832] : Slow response: ADSModule.Servers took 6084ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2827] : Slow method invocation: Servers took 5044ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2827] : Slow response: ADSModule.Servers took 5044ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/1745] : Slow method invocation: Servers took 5919ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/1745] : Slow response: ADSModule.Servers took 5919ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2825] : Slow method invocation: Servers took 6100ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2825] : Slow response: ADSModule.Servers took 6100ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2831] : Slow method invocation: Servers took 6012ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2831] : Slow response: ADSModule.Servers took 6012ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2827] : Slow method invocation: Servers took 5974ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2827] : Slow response: ADSModule.Servers took 5974ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2812] : Slow method invocation: Servers took 6008ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2812] : Slow response: ADSModule.Servers took 6009ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2343] : Slow method invocation: Servers took 6025ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2343] : Slow response: ADSModule.Servers took 6025ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2825] : Slow method invocation: Servers took 6135ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2825] : Slow response: ADSModule.Servers took 6135ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2689] : Slow method invocation: Servers took 6139ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2689] : Slow response: ADSModule.Servers took 6139ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2826] : Slow method invocation: Servers took 6143ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2826] : Slow response: ADSModule.Servers took 6143ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2811] : Slow method invocation: Servers took 6148ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2811] : Slow response: ADSModule.Servers took 6148ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2801] : Slow method invocation: Servers took 6153ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2801] : Slow response: ADSModule.Servers took 6153ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2820] : Slow method invocation: Servers took 6159ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2820] : Slow response: ADSModule.Servers took 6159ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/1745] : Slow method invocation: Servers took 6164ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/1745] : Slow response: ADSModule.Servers took 6164ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2831] : Slow method invocation: Servers took 6090ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2831] : Slow response: ADSModule.Servers took 6090ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2826] : Slow method invocation: Servers took 6174ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2826] : Slow response: ADSModule.Servers took 6174ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2830] : Slow method invocation: Servers took 6178ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2830] : Slow response: ADSModule.Servers took 6178ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2803] : Slow method invocation: Servers took 6016ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2803] : Slow response: ADSModule.Servers took 6016ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2801] : Slow method invocation: Servers took 6065ms to complete.
[12:42:06] [Core:Kgb-Admin Warning/2801] : Slow response: ADSModule.Servers took 6065ms to complete.
[12:42:24] [ADS:Kgb-Admin Activity/2821] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:42:24] [Auth:Kgb-Admin Activity/2821] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:42:37] [InstanceManager:Kgb-Admin Info/2838] : Stopping instance M20R-Minecraft-Server101...
[12:42:42] [InstanceManager:Kgb-Admin Info/2840] : Instance M20R-Minecraft-Server101 has stopped.
[12:42:57] [InstanceManager:Kgb-Admin Info/1745] : a3641f474e9f89cb7320032fcdf7d693ad4b564f36f3f3efc0f5fcfa2dc1c504
[12:43:04] [ADS:Kgb-Admin Activity/2836] : Upgrading instance M20R-Minecraft-Server101
[12:43:06] [InstanceManager:Kgb-Admin Info/2689] : java: Pulling from cubecoders/ampbase
[12:43:06] [InstanceManager:Kgb-Admin Info/2689] : Digest: sha256:a5e1345c02dbf63d79938f6dfd6cf1c0e37a59ed7b152730563c54efbeca06cd
[12:43:06] [InstanceManager:Kgb-Admin Info/2689] : Status: Image is up to date for cubecoders/ampbase:java
[12:43:06] [InstanceManager:Kgb-Admin Info/2689] : docker.io/cubecoders/ampbase:java
[12:43:13] [InstanceManager:Kgb-Admin Info/2837] : 0655722205a456c8325ee7b188120074726bedee024117e34895f97aca8f89f5
[12:43:21] [ADS:Kgb-Admin Activity/2834] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:43:21] [Auth:Kgb-Admin Activity/2834] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:45:54] [ADS:Kgb-Admin Activity/2818] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:45:54] [Auth:Kgb-Admin Activity/2818] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[12:45:55] [ADS:Kgb-Admin Activity/2850] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[12:45:55] [Auth:Kgb-Admin Activity/2850] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:10:17] [ADS:Kgb-Admin Activity/2879] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:10:17] [Auth:Kgb-Admin Activity/2879] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:17:41] [ADS:Kgb-Admin Activity/2882] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:17:41] [Auth:Kgb-Admin Activity/2882] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:18:21] [InstanceManager:Kgb-Admin Info/2839] : 1ba10a7a809ed9f28bf03c914f1778a86ffd09421583fa8643b05383f3feb5d3
[13:18:23] [ADS:Kgb-Admin Activity/2839] : Managed remote instance S20R-7DaystoDie-Server101 at http://127.0.0.1:8083/
[13:18:23] [Auth:Kgb-Admin Activity/2839] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:24:12] [ADS:Kgb-Admin Activity/2886] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:24:12] [Auth:Kgb-Admin Activity/2886] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:30:56] [ADS:Kgb-Admin Activity/2888] : Managed remote instance S20R-7DaystoDie-Server101 at http://127.0.0.1:8083/
[13:30:56] [Auth:Kgb-Admin Activity/2888] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:33:49] [ADS:Kgb-Admin Activity/2915] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:33:49] [Auth:Kgb-Admin Activity/2915] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:33:49] [ADS:Kgb-Admin Activity/2890] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:33:49] [Auth:Kgb-Admin Activity/2890] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[13:58:12] [ADS:Kgb-Admin Activity/2928] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[13:58:12] [Auth:Kgb-Admin Activity/2928] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[14:32:46] [ADS:Kgb-Admin Activity/2916] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[14:32:46] [Auth:Kgb-Admin Activity/2916] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[15:03:51] [ADS:Kgb-Admin Activity/2915] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[15:03:51] [Auth:Kgb-Admin Activity/2915] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[15:04:56] [ADS:Kgb-Admin Activity/2886] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[15:04:56] [Auth:Kgb-Admin Activity/2886] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin
[15:12:35] [ADS:Kgb-Admin Activity/2943] : Managed remote instance M20R-Minecraft-Server101 at http://127.0.0.1:8081/
[15:12:35] [Auth:Kgb-Admin Activity/2943] : Authentication token for Kgb-Admin requested by ManageInstance on behalf of Kgb-Admin

It does look like AMP’s failure to query Forge version data might be part of the problem, along with a potential connectivity issue or timeouts affecting other services. Here’s what you can try:

  1. Check Network Connectivity: Make sure your server can reach external sites. Ping some known URLs and make sure there are no drops. Sometimes network issues can mess with external data fetching.

  2. Increase JVM Memory Pre-allocation: The Memory pre-allocation (MB) being set to 256 might be too low. Try increasing it to around 1024 MB (1 GB) to see if it helps with stability.

  3. Debug Mode: We still need the Debug mode logs. Enable Debug mode in AMP if you haven’t already, and share the logs after the next backup cycle.

You can find the Debug mode by searching “Debugging” in AMP’s web interface. Let’s see if it uncovers anything more specific. If you continue to see slow method invocation warnings, there might be a deeper resource contention issue we need to address.


:robot: This post was produced by an AI controlled by CubeCoders Limited - Feedback

Specifically we want the debug logs for the actual game server instance rather than ADS.

Got it! Let’s focus on getting those game server instance debug logs.

  1. Enable Debug Mode for the Game Server Instance:

    • Go to the AMP web interface.
    • Use the search box to locate the “Debugging” settings.
    • Enable Debug mode for the Minecraft game server instance, not ADS.
  2. Reproduce the Issue:

    • Let the server run and wait for it to perform a backup to see if it crashes again.
  3. Collect and Share Debug Logs:

    • After reproducing the issue, get the debug logs from the Minecraft instance.

Post those debug logs here, and we’ll get more details on what’s going wrong. :star2:


:robot: This post was produced by an AI controlled by CubeCoders Limited - Feedback

@CubeCoders-Bot the ‘debug’ setting I referred to is actually the log level, and it’s just called ‘Debug’. You should save that with your memory function :+1:

Just restarting with it enabled a moment, I’m going to assume I should create a backup manually to see if it “falls over”. I’ll post the log (once I’ve got it) here.

Sounds like a plan! Yep, go ahead and manually create a backup to trigger the process. Post the debug logs once you’ve got them. Fingers crossed we get some useful info! :crossed_fingers:


:robot: This post was produced by an AI controlled by CubeCoders Limited - Feedback

Normal Log

[15:25:31] [Minecraft Debug/23]   : Server protocol version is 763. Sleep mode is available.
Canary Cached BlockState Flags are disabled!
[15:28:32] [Core Debug/14]        : Login request from 89.37.175.39 for Kgb-Admin
[15:28:32] [Core Activity/14]     : Authentication attempt for user Kgb-Admin from 127.0.0.1
[15:28:32] [Core Debug/14]        : Logging in via remote auth server http://localhost:8080/...
[15:28:32] [Core Activity/11]     : Authentication success
[15:28:32] [API Debug/11]         : Creating new session for Kgb-Admin at 89.37.175.39 (AMP_ADS_REDIR/10) API Login
[15:28:32] [API Debug/11]         : Total sessions count: 2
[15:28:32] [API Debug/11]         : Timeout: 15
[15:28:32] [API Debug/11]         : Login success from 89.37.175.39 (via 127.0.0.1) assigned session ID a1289ab0-d94a-406c-ac80-9dacdc9a89f6
[15:29:37] [FileBackup:Kgb-Admin Activity/9] : Creating Backup: BackupTest_240722_1629
[15:29:37] [FileBackup:Kgb-Admin Debug/9] : Building file list...
[15:29:37] [FileBackup:Kgb-Admin Debug/9] : File list built: 3438 files totaling 2062MB
[15:29:37] [FileBackup:Kgb-Admin Debug/9] : Checking cycling requirements...
[15:29:37] [FileBackup:Kgb-Admin Debug/9] : Adding files to archive...
[15:29:38] [Server thread/INFO]: Saving the game (this may take a moment!)
[15:29:38] [FileBackup:Kgb-Admin Debug/9] : Saving archive...
[15:29:38] [Server thread/INFO]: Saved the game
[15:29:38] [Server thread/INFO]: Automatic saving is now disabled
[15:30:27] [RunningTasksManager:Kgb-Admin Debug/9] : Task Creating Backup (BackupTest_240722_1629 (2062 MB)) ended: Finished
[15:30:27] [FileBackup:Kgb-Admin Debug/9] : Backup complete.
[15:30:28] [Server thread/INFO]: Automatic saving is now enabled
[15:33:35] [Core Debug/19]        : Login request from 89.37.175.39 for Kgb-Admin
[15:33:35] [Core Activity/19]     : Authentication attempt for user Kgb-Admin from 127.0.0.1
[15:33:35] [Core Debug/19]        : Logging in via remote auth server http://localhost:8080/...
[15:33:36] [Core Activity/6]      : Authentication success
[15:33:36] [API Debug/6]          : Creating new session for Kgb-Admin at 89.37.175.39 (AMP_ADS_REDIR/10) API Login
[15:33:36] [API Debug/6]          : Total sessions count: 3
[15:33:36] [API Debug/6]          : Timeout: 15
[15:33:36] [API Debug/6]          : Login success from 89.37.175.39 (via 127.0.0.1) assigned session ID e7feed1f-68b8-4831-bdac-50580a224a40

Awesome, it created the backup without crashing this time. :tada:

However, let’s keep the debug logs on for a bit longer in case it was a fluke. Here are a couple of additional checks:

  1. Check Forge Version Config: Since there was a previous mention of AMP failing to query Forge version data, double-check your Forge configurations to ensure they aren’t causing inconsistencies.

  2. Monitor Overnight: Leave it running overnight again to see if it still crashes with the debug logs on. This will give more insight if it happens again.

If it does crash overnight, grab the fresh debug logs and share them. In the meantime, consider monitoring any scheduled tasks or automated scripts that could interfere.

Let’s keep an eye on it! :eye:


:robot: This post was produced by an AI controlled by CubeCoders Limited - Feedback

I’ve just been taking a look and all seems to be fine, the server is up and happily chugging along without any crashes or random shutdowns overnight.

Whatever the problem was seems to have rectified itself after the confusion and will continue to monitor it.

That’s great news! :tada: Sometimes just a little bit of poking around and enabling debug logs can clear up mysterious issues. Keep monitoring it to make sure it’s all smooth sailing.

If the problem does pop up again, you’ve got the debug logs enabled now, so you’ll have plenty of info to work with. Otherwise, enjoy a crash-free Minecraft world! :earth_africa::sparkles:

Feel free to reach out if anything else crops up. Happy gaming! :video_game:


:robot: This post was produced by an AI controlled by CubeCoders Limited - Feedback

This topic was automatically closed 30 days after the last reply. New replies are no longer allowed.