Docker not able to find Minecraft executable

[Jeremiah]

OS Name/Version: Windows 11 Pro

Product Name/Version: (Always use the full version number - not ‘Latest’)

Problem Description: Running Docker on windows 11 pro. Followed the exact steps to setup docker containers for amp. Instance starts fine, but when the application starts, the following errors are received below. I can see the files when looking at the container files, but it seems the execution command might not be getting to the directory path properly.

2023-10-10 17:19:20 [21:19:20] [API:jrose323 Activity] : Updating the application.
2023-10-10 17:19:41 [21:19:41] [API:jrose323 Activity] : Starting the application.
2023-10-10 17:19:41 [21:19:41] [Logger:jrose323 Error] : Unable to start Minecraft Server
2023-10-10 17:19:41 [21:19:41] [Core:jrose323 Error]  : PlatformException
2023-10-10 17:19:41 [21:19:41] [Logger:jrose323 Error] : [0] (PlatformException) : ApplicationName='./Minecraft/bedrock_server', CommandLine='', CurrentDirectory='./Minecraft/', Native error= Cannot find the specified file
2023-10-10 17:19:41 [21:19:41] [Core:jrose323 Error]  :   at Diagnostics.Process.StartWithCreateProcess (Diagnostics.ProcessStartInfo startInfo) 
2023-10-10 17:19:41   at Diagnostics.Process.Start () 
2023-10-10 17:19:41   at ModuleShared.AMPProcess.Start () 
2023-10-10 17:19:41   at (wrapper remoting-invoke-with-check) ModuleShared.AMPProcess.Start()
2023-10-10 17:19:41   at MinecraftModule.MinecraftApp.StartGameServer (Boolean autoRetry)

Steps to reproduce:

• Installed Docker for windows
• Updated AMP config according to docker article.
• created new instance with full update and start

Actions taken to resolve so far:
*Tried using Java, wine, and wine8 image in container config. All three have same result
*rebooted server

[Mike]

What does the log say when you hit Update?

[Jeremiah]

Thats shown at the top of the log. It shows updating application and then tries to start it.

[Mike]

Can you turn on Debug logging? Diagnosing AMP/Application startup issues

[Jeremiah]

Ill do that now. In the meantime, this is the logging I got from Docker

2023-10-11 09:04:26 [Info] AMPStart for Docker - v23.07.1
2023-10-11 09:04:26 [Info] Performing first-time container setup…
2023-10-11 09:04:27 [Info] Container setup complete.
2023-10-11 09:04:27 [Info] No missing dependencies to install.
2023-10-11 09:04:27 [Info] AMP Instance Manager v2.4.6.2 built 30/08/2023 14:38
2023-10-11 09:04:27 [Info] Stream: Mainline / Release - built by CUBECODERS/buildbot on CCL-DEV
2023-10-11 09:04:33 [Info] Certificates have been synced.
2023-10-11 09:04:36 [13:04:36] [Logger Info] : Starting AMP version 2.4.6.6 (Decadeus), built 05/10/2023 11:56
2023-10-11 09:04:36 [13:04:36] [Logger Info] : Stream: Mainline / Release - built by CUBECODERS/buildbot on CCL-DEV
2023-10-11 09:04:36 [13:04:36] [Logger Info] : Running in a Docker environment.
2023-10-11 09:04:36 [13:04:36] [Logger Info] : OS: Linux / x86_64
2023-10-11 09:04:36 [13:04:36] [Logger Info] : CPU: Intel(R) N100 (4C/4T)
2023-10-11 09:04:36 [13:04:36] [Logger Info] : RAM: 7832MB
2023-10-11 09:04:36 [13:04:36] [Logger Info] : AMP Instance ID: eda82e8e-d2a8-44ed-9936-e40005dc1f03
2023-10-11 09:04:26 useradd: warning: the home directory /home/amp already exists.
2023-10-11 09:04:26 useradd: Not copying any file from skel directory into it.
2023-10-11 09:04:37 [13:04:37] [Logger Info] : Loaded MinecraftModule version 1.0.0.3 by CubeCoders Limited
2023-10-11 09:04:38 [13:04:37] [Logger Info] : Metrics publishing is enabled at udp://host.docker.internal:12820.
2023-10-11 09:04:38 [13:04:38] [Logger Info] : Loaded FileManagerPlugin by CubeCoders Limited
2023-10-11 09:04:38 [13:04:38] [Logger Info] : Loaded EmailSenderPlugin by CubeCoders Limited
2023-10-11 09:04:38 [13:04:38] [Logger Info] : Loaded WebRequestPlugin by CubeCoders Limited
2023-10-11 09:04:38 [13:04:38] [Logger Info] : Loaded LocalFileBackupPlugin by CubeCoders Limited
2023-10-11 09:04:38 [13:04:38] [Logger Info] : Loaded CommonCorePlugin by CubeCoders Limited
2023-10-11 09:04:39 [13:04:39] [Logger Info] : Licence Present: AMP Standard Edition
2023-10-11 09:04:39 [13:04:39] [FileManager Error] : Unable to start SFTP server.
2023-10-11 09:04:39 [13:04:39] [Core Error] : SocketException
2023-10-11 09:04:39 [13:04:39] [Logger Error] : [0] (SocketException) : The requested address is not valid in this context
2023-10-11 09:04:39 [13:04:39] [Core Error] : at Net.Sockets.Socket.Bind (Net.EndPoint localEP)
2023-10-11 09:04:39 at kdbmv.ssrok.thtoq (Net.EndPoint p0, Boolean p1)
2023-10-11 09:04:39 at kdbmv.ssrok…ctor (Net.EndPoint ep, String hostname, kdbmv.xqkcu runner)
2023-10-11 09:04:39 at Rebex.Net.Servers.Core.Server.Bind (Net.IPEndPoint endPoint, Rebex.Net.Servers.Core.ServerModule module)
2023-10-11 09:04:39 at Rebex.Net.Servers.FileServer.Bind (Net.IPEndPoint endPoint, Rebex.Net.Servers.FileServerProtocol module)
2023-10-11 09:04:39 at FileManagerPlugin.PluginMain.PostInit ()
2023-10-11 09:04:39 [13:04:39] [Webserver Info] : Websockets are enabled.
2023-10-11 09:04:39 [13:04:39] [Logger Info] : RouterTimer@10Hz with 2 jobs started
2023-10-11 09:04:39 [13:04:39] [Logger Info] : Webserver started on http://0.0.0.0:8082
2023-10-11 09:04:39 [13:04:39] [Core Info] : Checking for AMP updates…
2023-10-11 09:04:39 [13:04:39] [Logger Info] : Startup mode is UpdateApplication.
2023-10-11 09:04:40 [13:04:40] [Core Info] : AMP is up to date.
2023-10-11 09:04:42 [13:04:42] [Logger Info] : Updating Modpack cache for 85 modpacks…
2023-10-11 09:04:58 [13:04:57] [Logger Activity] : Authentication attempt for user jrose323 from 172.17.0.1
2023-10-11 09:04:58 [13:04:58] [Core Activity] : Authentication success
2023-10-11 09:05:04 [13:05:04] [Logger Info] : Update complete.
2023-10-11 09:05:05 [13:05:05] [API:jrose323 Activity] : Updating the application.
2023-10-11 09:05:05 [13:05:05] [Core Error] : FileNotFoundException
2023-10-11 09:05:05 [13:05:05] [Logger Error] : [0] (FileNotFoundException) : Could not find file ‘/tmp/wsyc1ctq.ttd’.
2023-10-11 09:05:06 [13:05:05] [Core Error] : at IO.File.Move (String sourceFileName, String destFileName)
2023-10-11 09:05:06 at ModuleShared.Utilities.DownloadFileWithProgressAsync (String url, String filename, ModuleShared.RunningTask task, Boolean autoRemoveTask, String UserAgent)
2023-10-11 09:05:40 [13:05:40] [API:jrose323 Activity] : Updating the application.
2023-10-11 09:08:42 [13:08:42] [Logger Activity] : Authentication attempt for user jrose323 from 172.17.0.1
2023-10-11 09:08:42 [13:08:42] [Core Activity] : Authentication success
2023-10-11 09:08:45 [13:08:45] [API:jrose323 Activity] : Starting the application.
2023-10-11 09:08:48 [13:08:48] [API:jrose323 Activity] : Starting the application.
2023-10-11 09:08:48 [13:08:48] [Logger:jrose323 Error] : Unable to start Minecraft Server
2023-10-11 09:08:48 [13:08:48] [Core:jrose323 Error] : PlatformException
2023-10-11 09:08:48 [13:08:48] [Logger:jrose323 Error] : [0] (PlatformException) : ApplicationName=‘./Minecraft/bedrock_server’, CommandLine=‘’, CurrentDirectory=‘./Minecraft/’, Native error= Cannot find the specified file
2023-10-11 09:08:48 [13:08:48] [Core:jrose323 Error] : at Diagnostics.Process.StartWithCreateProcess (Diagnostics.ProcessStartInfo startInfo)
2023-10-11 09:08:48 at Diagnostics.Process.Start ()
2023-10-11 09:08:48 at ModuleShared.AMPProcess.Start ()
2023-10-11 09:08:48 at (wrapper remoting-invoke-with-check) ModuleShared.AMPProcess.Start()
2023-10-11 09:08:48 at MinecraftModule.MinecraftApp.StartGameServer (Boolean autoRetry)

[Mike]

Interesting, it can’t access /tmp/ inside the container for some reason so it can’t store temporary files…

[Jeremiah]

Do you still need the debug from the AMP application or is this good enough?

[Mike]

This’ll do for now - let me get back to you on this.

[Jeremiah]

Just checking in for a potential ETR?

[Mike]

None right now since it’s in the queue to be investigated. Workaround for now is to switch off Docker mode.

[IceOfWraith]

For reference… Should just be a regex fix.

Minecraft Bedrock Doesn't Show "Started" on Some Instances