microsoft / malmo

Project Malmo is a platform for Artificial Intelligence experimentation and research built on top of Minecraft. We aim to inspire a new generation of research into challenging new problems presented by this unique environment. --- For installation instructions, scroll down to *Getting Started* below, or visit the project page for more information:
https://www.microsoft.com/en-us/research/project/project-malmo/
MIT License
4.08k stars 600 forks source link

Cannot launch run_mission.py #645

Closed ongzexuan closed 6 years ago

ongzexuan commented 6 years ago

I just installed malmo on Windows 10 using the .bat scripts provided. However when I try to run the run_mission.py file, nothing happens. I get the following error message:

PS C:\Users\Ze Xuan\Malmo-0.31.0-Windows-64bit_Python3.6\Python_Examples> py .\run_mission.py`
Exception in closing of MissionRecord: boost::filesystem::remove: The process cannot access the file because it is being used by another process: ".\mission_records\9aeabb62-7c00-4023-9f38-fa53727899d8\commands.txt"`
Exception in closing of MissionRecord: boost::filesystem::remove: The process cannot access the file because it is being used by another process: ".\mission_records\3d1bb0e7-0186-44b6-97ee-cd97d66c4fb1\commands.txt"`
Error starting mission: Failed to find an available client for this mission - tried all the clients in the supplied client pool.`

The following is my Minecraft log:

PS C:\Users\Ze Xuan\Malmo-0.31.0-Windows-64bit_Python3.6\Minecraft> .\launchClient.bat
This mapping 'snapshot_20161220' was designed for MC 1.11! Use at your own peril.
#################################################
         ForgeGradle 2.2-SNAPSHOT-d13a6c8
  https://github.com/MinecraftForge/ForgeGradle
#################################################
               Powered by MCP unknown
             http://modcoderpack.com
         by: Searge, ProfMobius, Fesh0r,
         R4wk, ZeuX, IngisKahn, bspkrs
#################################################
:deobfCompileDummyTask
:deobfProvidedDummyTask
:getVersionJson
:extractUserdev UP-TO-DATE
:extractDependencyATs SKIPPED
:extractMcpData SKIPPED
:extractMcpMappings SKIPPED
:genSrgs SKIPPED
:downloadClient SKIPPED
:downloadServer SKIPPED
:splitServerJar SKIPPED
:mergeJars SKIPPED
:deobfMcSRG SKIPPED
:decompileMc SKIPPED
:fixMcSources SKIPPED
:applySourcePatches
:remapMcSources SKIPPED
:recompileMc SKIPPED
:extractNatives SKIPPED
:getAssetIndex UP-TO-DATE
:getAssets
Current status: 1192/1196   99%
:makeStart
:setupDecompWorkspace

BUILD SUCCESSFUL

Total time: 13.568 secs
This mapping 'snapshot_20161220' was designed for MC 1.11! Use at your own peril.
#################################################
         ForgeGradle 2.2-SNAPSHOT-d13a6c8
  https://github.com/MinecraftForge/ForgeGradle
#################################################
               Powered by MCP unknown
             http://modcoderpack.com
         by: Searge, ProfMobius, Fesh0r,
         R4wk, ZeuX, IngisKahn, bspkrs
#################################################
:deobfCompileDummyTask
:deobfProvidedDummyTask
:sourceApiJava UP-TO-DATE
:compileApiJava UP-TO-DATE
:processApiResources UP-TO-DATE
:apiClasses UP-TO-DATE
:copyModToClient
:copyModToServer
:deleteSchemas
:copySchemas
:jaxb UP-TO-DATE
:sourceMainJava UP-TO-DATE
:compileJava
warning: [options] bootstrap class path not set in conjunction with -source 1.6
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.
Note: Some input files use unchecked or unsafe operations.
Note: Recompile with -Xlint:unchecked for details.
1 warning
:processResources UP-TO-DATE
:classes
:jar UP-TO-DATE
:sourceTestJava UP-TO-DATE
:compileTestJava UP-TO-DATE
:processTestResources UP-TO-DATE
:testClasses UP-TO-DATE
:test UP-TO-DATE
:extractMcpData SKIPPED
:extractMcpMappings SKIPPED
:getVersionJson
:extractUserdev UP-TO-DATE
:genSrgs SKIPPED
:reobfJar
:assemble
:check UP-TO-DATE
:build

BUILD SUCCESSFUL

Total time: 9.15 secs
This mapping 'snapshot_20161220' was designed for MC 1.11! Use at your own peril.
#################################################
         ForgeGradle 2.2-SNAPSHOT-d13a6c8
  https://github.com/MinecraftForge/ForgeGradle
#################################################
               Powered by MCP unknown
             http://modcoderpack.com
         by: Searge, ProfMobius, Fesh0r,
         R4wk, ZeuX, IngisKahn, bspkrs
#################################################
:deobfCompileDummyTask
:deobfProvidedDummyTask
:sourceApiJava UP-TO-DATE
:compileApiJava UP-TO-DATE
:processApiResources UP-TO-DATE
:apiClasses UP-TO-DATE
:copyModToClient
:copyModToServer
:deleteSchemas
:copySchemas
:jaxb UP-TO-DATE
:sourceMainJava UP-TO-DATE
:compileJava
warning: [options] bootstrap class path not set in conjunction with -source 1.6
Note: Some input files use or override a deprecated API.
Note: Recompile with -Xlint:deprecation for details.
Note: Some input files use unchecked or unsafe operations.
Note: Recompile with -Xlint:unchecked for details.
1 warning
:processResources UP-TO-DATE
:classes
:jar
:getVersionJson
:extractNatives SKIPPED
:extractUserdev UP-TO-DATE
:getAssetIndex UP-TO-DATE
:getAssets
Current status: 1060/1196   88%
:makeStart
:runClient
2017-12-19 21:12:11,218 WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
2017-12-19 21:12:11,219 WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
[21:12:11] [main/INFO] [GradleStart]: Extra: []
[21:12:11] [main/INFO] [GradleStart]: Found and added coremod: com.microsoft.Malmo.OverclockingPlugin
[21:12:11] [main/INFO] [GradleStart]: Running with arguments: [--userProperties, {}, --assetsDir, C:/Users/Ze Xuan/.gradle/caches/mine
craft/assets, --assetIndex, 1.11, --accessToken{REDACTED}, --version, 1.11.2, --tweakClass, net.minecraftforge.fml.common.launcher.FML
Tweaker, --tweakClass, net.minecraftforge.gradle.tweakers.CoremodTweaker]
[21:12:11] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.FMLTweaker
[21:12:11] [main/INFO] [LaunchWrapper]: Using primary tweak class name net.minecraftforge.fml.common.launcher.FMLTweaker
[21:12:11] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.gradle.tweakers.CoremodTweaker
[21:12:11] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLTweaker
[21:12:11] [main/INFO] [FML]: Forge Mod Loader version 13.20.0.2228 for Minecraft 1.11.2 loading
[21:12:11] [main/INFO] [FML]: Java is Java HotSpot(TM) 64-Bit Server VM, version 1.8.0_131, running on Windows 10:amd64:10.0, installe
d at C:\Program Files\Java\jdk1.8.0_131\jre
[21:12:11] [main/INFO] [FML]: Managed to load a deobfuscated Minecraft name- we are in a deobfuscated environment. Skipping runtime de
obfuscation
[21:12:11] [main/INFO] [FML]: Found a command line coremod : com.microsoft.Malmo.OverclockingPlugin
[21:12:11] [main/WARN] [FML]: The coremod com.microsoft.Malmo.OverclockingPlugin does not have a MCVersion annotation, it may cause is
sues with this version of Minecraft
[21:12:11] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.gradle.tweakers.CoremodTweaker
[21:12:11] [main/INFO] [GradleStart]: Injecting location in coremod net.minecraftforge.fml.relauncher.FMLCorePlugin
[21:12:11] [main/INFO] [GradleStart]: Injecting location in coremod net.minecraftforge.classloading.FMLForgePlugin
[21:12:11] [main/INFO] [GradleStart]: Injecting location in coremod com.microsoft.Malmo.OverclockingPlugin
[21:12:11] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.FMLInjectionAndSortingTweaker
[21:12:11] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.FMLDeobfTweaker
[21:12:11] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.gradle.tweakers.AccessTransformerTweaker
[21:12:11] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLInjectionAndSortingTweaker
[21:12:11] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLInjectionAndSortingTweaker
[21:12:11] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.relauncher.CoreModManager$FMLPluginWrapper
[21:12:11] [main/ERROR] [FML]: The binary patch set is missing. Either you are in a development environment, or things are not going t
o work!
[21:12:11] [main/ERROR] [FML]: FML appears to be missing any signature data. This is not a good thing
[21:12:11] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.relauncher.CoreModManager$FMLPluginWrapper
[21:12:11] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.relauncher.CoreModManager$FMLPluginWrapper
[21:12:11] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLDeobfTweaker
[21:12:12] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.gradle.tweakers.AccessTransformerTweaker
[21:12:12] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.TerminalTweaker
[21:12:12] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.TerminalTweaker
[21:12:12] [main/INFO] [LaunchWrapper]: Launching wrapped minecraft {net.minecraft.client.main.Main}
[21:12:12] [main/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:transform:58]: MALMO: Attempting to transform Minec
raftServer
[21:12:12] [main/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:overclockRenderer:187]: MALMO: Found Minecraft, att
empting to transform it
[21:12:12] [main/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:overclockRenderer:193]: MALMO: Found Minecraft.runG
ameLoop() method, attempting to transform it
[21:12:12] [main/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:overclockRenderer:208]: MALMO: Hooked into call to
Minecraft.updateDisplay()
[21:12:12] [main/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:transform:42]: net.minecraft.client.entity.EntityPl
ayerSP
[21:12:12] [main/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:transform:42]: net.minecraft.client.entity.Abstract
ClientPlayer
2017-12-19 21:12:12,486 WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
2017-12-19 21:12:12,496 WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
2017-12-19 21:12:12,496 WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
[21:12:12] [Client thread/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:transform:58]: MALMO: Attempting to transf
orm MinecraftServer
[21:12:12] [Client thread/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:overclockServer:123]: MALMO: Found Minecra
ftServer, attempting to transform it
[21:12:12] [Client thread/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:overclockServer:129]: MALMO: Found Minecra
ftServer.run() method, attempting to transform it
[21:12:12] [Client thread/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:overclockServer:137]: MALMO: Transforming
LDC
[21:12:12] [Client thread/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:overclockServer:137]: MALMO: Transforming
LDC
[21:12:12] [Client thread/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:overclockServer:137]: MALMO: Transforming
LDC
[21:12:12] [Client thread/INFO] [STDOUT]: [com.microsoft.Malmo.OverclockingClassTransformer:overclockServer:137]: MALMO: Transforming
LDC
[21:12:12] [Client thread/INFO]: Setting user: Player189
[21:12:15] [Client thread/WARN]: Skipping bad option: lastServer:
[21:12:15] [Client thread/INFO]: LWJGL Version: 2.9.4
[21:12:15] [Client thread/INFO]: [STDOUT]: MALMO: Attempting to transform MinecraftServer
[21:12:15] [Client thread/INFO]: [STDOUT]: MALMO: Found GlStateManager, attempting to transform it
[21:12:15] [Client thread/INFO]: [STDOUT]: MALMO: Found GlStateManager.bindTexture() method, attempting to transform it
[21:12:15] [Client thread/INFO]: [STDOUT]: MALMO: Hooked into call to GlStateManager.bindTexture()
[21:12:15] [Client thread/INFO]: [STDOUT]: ---- Minecraft Crash Report ----
// But it works on my machine.

Time: 12/19/17 9:12 PM
Description: Loading screen debug info

This is just a prompt for computer specs to be printed. THIS IS NOT A ERROR

A detailed walkthrough of the error, its code path and all known details is as follows:
---------------------------------------------------------------------------------------

-- System Details --
Details:
       Minecraft Version: 1.11.2
      Operating System: Windows 10 (amd64) version 10.0
      Java Version: 1.8.0_131, Oracle Corporation
    Java VM Version: Java HotSpot(TM) 64-Bit Server VM (mixed mode), Oracle Corporation
    Memory: 608345016 bytes (580 MB) / 854589440 bytes (815 MB) up to 1908932608 bytes (1820 MB)
   JVM Flags: 1 total; -Xmx2G
     IntCache: cache: 0, tcache: 0, allocated: 0, tallocated: 0
     FML:
  Loaded coremods (and transformers):
OverclockingPlugin (MalmoMod-0.31.0.jar)
  com.microsoft.Malmo.OverclockingClassTransformer
       GL info: ' Vendor: 'VMware, Inc.' Version: '2.1 Mesa 10.0.1' Renderer: 'Gallium 0.4 on llvmpipe (LLVM 3.3, 256 bits)'
[21:12:15] [Client thread/INFO] [FML]: MinecraftForge v13.20.0.2228 Initialized
[21:12:15] [Client thread/INFO] [FML]: Replaced 232 ore recipes
[21:12:16] [Client thread/INFO] [FML]: Found 0 mods from the command line. Injecting into mod discoverer
[21:12:16] [Client thread/INFO] [FML]: Searching C:\Users\Ze Xuan\Malmo-0.31.0-Windows-64bit_Python3.6\Minecraft\run\mods for mods
[21:12:16] [Client thread/INFO] [FML]: Forge Mod Loader has identified 5 mods to load
[21:12:16] [Client thread/INFO] [FML]: Attempting connection with missing mods [minecraft, mcp, FML, forge, malmomod] at CLIENT
[21:12:16] [Client thread/INFO] [FML]: Attempting connection with missing mods [minecraft, mcp, FML, forge, malmomod] at SERVER
[21:12:17] [Client thread/INFO]: Reloading ResourceManager: Default, FMLFileResourcePack:Forge Mod Loader, FMLFileResourcePack:Minecra
ft Forge, FMLFileResourcePack:Microsoft Malmo Mod
[21:12:17] [Client thread/WARN]: ResourcePack: ignored non-lowercase namespace: MalmoMod in C:\Users\Ze Xuan\Malmo-0.31.0-Windows-64bi
t_Python3.6\Minecraft\build\libs\MalmoMod-0.31.0.jar
[21:12:17] [Client thread/WARN]: ResourcePack: ignored non-lowercase namespace: MalmoMod in C:\Users\Ze Xuan\Malmo-0.31.0-Windows-64bi
t_Python3.6\Minecraft\build\libs\MalmoMod-0.31.0.jar
[21:12:17] [Client thread/WARN]: ResourcePack: ignored non-lowercase namespace: MalmoMod in C:\Users\Ze Xuan\Malmo-0.31.0-Windows-64bi
t_Python3.6\Minecraft\build\libs\MalmoMod-0.31.0.jar
[21:12:17] [Client thread/INFO] [FML]: Processing ObjectHolder annotations
[21:12:17] [Client thread/INFO] [FML]: Found 444 ObjectHolder annotations
[21:12:17] [Client thread/INFO] [FML]: Identifying ItemStackHolder annotations
[21:12:17] [Client thread/INFO] [FML]: Found 0 ItemStackHolder annotations
[21:12:17] [Client thread/INFO] [FML]: Applying holder lookups
[21:12:17] [Client thread/INFO] [FML]: Holder lookups applied
[21:12:17] [Client thread/INFO] [FML]: Applying holder lookups
[21:12:17] [Client thread/INFO] [FML]: Holder lookups applied
[21:12:17] [Client thread/INFO] [FML]: Applying holder lookups
[21:12:17] [Client thread/INFO] [FML]: Holder lookups applied
[21:12:17] [Client thread/INFO] [FML]: Configured a dormant chunk cache size of 0
[21:12:17] [Client thread/INFO]: [STDOUT]: Testing schemas against internal version number: 0.31
[21:12:17] [Forge Version Check/INFO] [ForgeVersionCheck]: [forge] Starting version check at http://files.minecraftforge.net/maven/net
/minecraftforge/forge/promotions_slim.json
[21:12:17] [Forge Version Check/INFO] [ForgeVersionCheck]: [forge] Found status: OUTDATED Target: 13.20.1.2386
[21:12:17] [Client thread/INFO] [FML]: Applying holder lookups
[21:12:17] [Client thread/INFO] [FML]: Holder lookups applied
[21:12:17] [Client thread/INFO] [FML]: Injecting itemstacks
[21:12:17] [Client thread/INFO] [FML]: Itemstack injection complete
[21:12:18] [Sound Library Loader/INFO]: Starting up SoundSystem...
[21:12:18] [Thread-8/INFO]: Initializing LWJGL OpenAL
[21:12:18] [Thread-8/INFO]: (The LWJGL binding of OpenAL.  For more information, see http://www.lwjgl.org)
[21:12:19] [Thread-8/INFO]: OpenAL initialized.
[21:12:19] [Sound Library Loader/INFO]: Sound engine started
[21:12:20] [Client thread/INFO] [FML]: Max texture size: 8192
[21:12:20] [Client thread/INFO]: Created: 16x16 textures-atlas
[21:12:21] [Client thread/INFO]: [STDOUT]: CLIENT request state: WAITING_FOR_MOD_READY
[21:12:21] [Client thread/INFO] [FML]: Injecting itemstacks
[21:12:21] [Client thread/INFO] [FML]: Itemstack injection complete
[21:12:21] [Client thread/INFO] [FML]: Forge Mod Loader has successfully loaded 5 mods
[21:12:21] [Client thread/INFO]: Reloading ResourceManager: Default, FMLFileResourcePack:Forge Mod Loader, FMLFileResourcePack:Minecra
ft Forge, FMLFileResourcePack:Microsoft Malmo Mod
[21:12:21] [Client thread/WARN]: ResourcePack: ignored non-lowercase namespace: MalmoMod in C:\Users\Ze Xuan\Malmo-0.31.0-Windows-64bi
t_Python3.6\Minecraft\build\libs\MalmoMod-0.31.0.jar
[21:12:21] [Client thread/WARN]: ResourcePack: ignored non-lowercase namespace: MalmoMod in C:\Users\Ze Xuan\Malmo-0.31.0-Windows-64bi
t_Python3.6\Minecraft\build\libs\MalmoMod-0.31.0.jar
[21:12:21] [Client thread/WARN]: ResourcePack: ignored non-lowercase namespace: MalmoMod in C:\Users\Ze Xuan\Malmo-0.31.0-Windows-64bi
t_Python3.6\Minecraft\build\libs\MalmoMod-0.31.0.jar
[21:12:22] [Client thread/INFO]: SoundSystem shutting down...
[21:12:22] [Client thread/WARN]: Author: Paul Lamb, www.paulscode.com
[21:12:22] [Sound Library Loader/INFO]: Starting up SoundSystem...
[21:12:22] [Thread-10/INFO]: Initializing LWJGL OpenAL
[21:12:22] [Thread-10/INFO]: (The LWJGL binding of OpenAL.  For more information, see http://www.lwjgl.org)
[21:12:22] [Thread-10/INFO]: OpenAL initialized.
[21:12:23] [Sound Library Loader/INFO]: Sound engine started
[21:12:23] [Client thread/INFO] [FML]: Max texture size: 8192
[21:12:23] [Client thread/INFO]: Created: 512x512 textures-atlas
[21:12:24] [Client thread/WARN]: Skipping bad option: lastServer:
[21:12:25] [Realms Notification Availability checker #1/INFO]: Could not authorize you against Realms server: Invalid session id
[21:12:25] [Client thread/INFO]: [STDOUT]: CLIENT enter state: WAITING_FOR_MOD_READY
[21:12:25] [Thread-12/INFO]: [STDOUT]: INFO: ->mcp(0) Listening for messages on port 10000
[21:12:25] [Client thread/INFO]: [STDOUT]: CLIENT request state: DORMANT
[21:12:25] [Client thread/INFO]: [STDOUT]: CLIENT enter state: DORMANT
[21:13:07] [Thread-14/INFO]: [STDOUT]: Received from 127.0.0.1:
[21:13:07] [Thread-14/INFO]: [STDOUT]: MALMO_REQUEST_CLIENT:0.31.0:20000:
[21:13:07] [Thread-14/INFO]: [STDOUT]: ==== RES:  - -1513735987523
[21:13:07] [Thread-14/INFO]: [STDOUT]: REPLYING WITH: MALMOOK
[21:13:09] [Thread-16/INFO]: [STDOUT]: Received from 127.0.0.1:
[21:13:09] [Thread-16/INFO]: [STDOUT]: MALMO_REQUEST_CLIENT:0.31.0:20000:
[21:13:09] [Thread-16/INFO]: [STDOUT]: ==== RES: RESERVED - 17970
[21:13:09] [Thread-16/INFO]: [STDOUT]: REPLYING WITH: MALMOBUSY
[21:13:11] [Thread-18/INFO]: [STDOUT]: Received from 127.0.0.1:
[21:13:11] [Thread-18/INFO]: [STDOUT]: MALMO_REQUEST_CLIENT:0.31.0:20000:
[21:13:11] [Thread-18/INFO]: [STDOUT]: ==== RES: RESERVED - 15906
[21:13:11] [Thread-18/INFO]: [STDOUT]: REPLYING WITH: MALMOBUSY

What seems to be the problem here?

ongzexuan commented 6 years ago

Ok I seemed to have resolved this issue. I think it was a combination of a number of issues, though not specifically sure which one was the main problem.

  1. Whitespace in my MALMO_XSD_PATH (unfortunately my home folder has a whitespace). That resolved some XML parsing problems #176
  2. My PYTHONPATH was pointing to the wrong directory since I moved my install folder
DaveyBiggers commented 6 years ago

Great, glad you got sorted in the end!