1.12 Item not rendering [First Mod]

[Squishling]

https://github.com/Squishling/Test-Mod

 

Hi.  I am Squishling.

I am having trouble with my first item's model rendering.  I have tried everything that I have found online, but no luck.

 

Goal: To have an item rendered with a texture.

Status: Black & purple cube.

 

I have included a link to my code (At the top) and my console output (below).

 

Spoiler

2017-10-15 19:37:27,675 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
2017-10-15 19:37:27,677 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
[19:37:27] [main/INFO] [GradleStart]: Extra: []
[19:37:27] [main/INFO] [GradleStart]: Running with arguments: [--userProperties, {}, --assetsDir, C:/Users/Vive/.gradle/caches/minecraft/assets, --assetIndex, 1.12, --accessToken{REDACTED}, --version, 1.12, --tweakClass, net.minecraftforge.fml.common.launcher.FMLTweaker, --tweakClass, net.minecraftforge.gradle.tweakers.CoremodTweaker]
[19:37:27] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.FMLTweaker
[19:37:27] [main/INFO] [LaunchWrapper]: Using primary tweak class name net.minecraftforge.fml.common.launcher.FMLTweaker
[19:37:27] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.gradle.tweakers.CoremodTweaker
[19:37:27] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLTweaker
[19:37:27] [main/INFO] [FML]: Forge Mod Loader version 14.21.1.2387 for Minecraft 1.12 loading
[19:37:27] [main/INFO] [FML]: Java is Java HotSpot(TM) 64-Bit Server VM, version 1.8.0_144, running on Windows 10:amd64:10.0, installed at C:\Program Files\Java\jre1.8.0_144
[19:37:27] [main/INFO] [FML]: Managed to load a deobfuscated Minecraft name- we are in a deobfuscated environment. Skipping runtime deobfuscation
[19:37:27] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.gradle.tweakers.CoremodTweaker
[19:37:27] [main/INFO] [GradleStart]: Injecting location in coremod net.minecraftforge.fml.relauncher.FMLCorePlugin
[19:37:27] [main/INFO] [GradleStart]: Injecting location in coremod net.minecraftforge.classloading.FMLForgePlugin
[19:37:27] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.FMLInjectionAndSortingTweaker
[19:37:27] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.FMLDeobfTweaker
[19:37:27] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.gradle.tweakers.AccessTransformerTweaker
[19:37:27] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLInjectionAndSortingTweaker
[19:37:27] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLInjectionAndSortingTweaker
[19:37:27] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.relauncher.CoreModManager$FMLPluginWrapper
2017-10-15 19:37:28,006 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
2017-10-15 19:37:28,210 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
2017-10-15 19:37:28,211 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
[19:37:28] [main/ERROR] [FML]: The binary patch set is missing. Either you are in a development environment, or things are not going to work!
[19:37:29] [main/ERROR] [FML]: FML appears to be missing any signature data. This is not a good thing
[19:37:29] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.relauncher.CoreModManager$FMLPluginWrapper
[19:37:29] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLDeobfTweaker
[19:37:29] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.gradle.tweakers.AccessTransformerTweaker
[19:37:29] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.TerminalTweaker
[19:37:29] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.TerminalTweaker
[19:37:29] [main/INFO] [LaunchWrapper]: Launching wrapped minecraft {net.minecraft.client.main.Main}
[19:37:30] [main/INFO]: Setting user: Player211
[19:37:32] [main/WARN]: Skipping bad option: lastServer:
[19:37:32] [main/INFO]: LWJGL Version: 2.9.4
[19:37:33] [main/INFO] [FML]: -- System Details --
Details:
	Minecraft Version: 1.12
	Operating System: Windows 10 (amd64) version 10.0
	Java Version: 1.8.0_144, Oracle Corporation
	Java VM Version: Java HotSpot(TM) 64-Bit Server VM (mixed mode), Oracle Corporation
	Memory: 800282456 bytes (763 MB) / 1037959168 bytes (989 MB) up to 1037959168 bytes (989 MB)
	JVM Flags: 3 total; -Xincgc -Xmx1024M -Xms1024M
	IntCache: cache: 0, tcache: 0, allocated: 0, tallocated: 0
	FML: 
	Loaded coremods (and transformers): 
	GL info: ' Vendor: 'NVIDIA Corporation' Version: '4.5.0 NVIDIA 382.53' Renderer: 'GeForce GTX 980/PCIe/SSE2'
[19:37:33] [main/INFO] [FML]: MinecraftForge v14.21.1.2387 Initialized
[19:37:33] [main/INFO] [FML]: Replaced 921 ore ingredients
[19:37:34] [main/INFO] [FML]: Found 0 mods from the command line. Injecting into mod discoverer
[19:37:34] [main/INFO] [FML]: Searching C:\Users\Vive\Desktop\Forge\run\mods for mods
[19:37:34] [main/INFO] [FML]: Forge Mod Loader has identified 5 mods to load
[19:37:34] [main/INFO] [FML]: Attempting connection with missing mods [minecraft, mcp, FML, forge, stestmod] at CLIENT
[19:37:34] [main/INFO] [FML]: Attempting connection with missing mods [minecraft, mcp, FML, forge, stestmod] at SERVER
[19:37:35] [main/INFO]: Reloading ResourceManager: Default, FMLFileResourcePack:Forge Mod Loader, FMLFileResourcePack:Minecraft Forge, FMLFileResourcePack:STestMod
[19:37:35] [main/INFO] [FML]: Processing ObjectHolder annotations
[19:37:35] [main/INFO] [FML]: Found 1168 ObjectHolder annotations
[19:37:35] [main/INFO] [FML]: Identifying ItemStackHolder annotations
[19:37:35] [main/INFO] [FML]: Found 0 ItemStackHolder annotations
[19:37:35] [main/INFO] [FML]: Configured a dormant chunk cache size of 0
[19:37:35] [Forge Version Check/INFO] [ForgeVersionCheck]: [forge] Starting version check at http://files.minecraftforge.net/maven/net/minecraftforge/forge/promotions_slim.json
[19:37:35] [main/INFO] [FML]: Applying holder lookups
[19:37:35] [main/INFO] [FML]: Holder lookups applied
[19:37:35] [main/INFO] [FML]: Applying holder lookups
[19:37:35] [main/INFO] [FML]: Holder lookups applied
[19:37:35] [main/INFO] [FML]: Applying holder lookups
[19:37:35] [main/INFO] [FML]: Holder lookups applied
[19:37:35] [main/INFO] [FML]: Applying holder lookups
[19:37:35] [main/INFO] [FML]: Holder lookups applied
[19:37:35] [main/INFO] [FML]: Injecting itemstacks
[19:37:35] [main/INFO] [FML]: Itemstack injection complete
[19:37:35] [Forge Version Check/INFO] [ForgeVersionCheck]: [forge] Found status: UP_TO_DATE Target: null
[19:37:35] [Thread-3/INFO] [FML]: Using sync timing. 200 frames of Display.update took 57120532 nanos
[19:37:37] [Sound Library Loader/INFO]: Starting up SoundSystem...
[19:37:37] [Thread-5/INFO]: Initializing LWJGL OpenAL
[19:37:37] [Thread-5/INFO]: (The LWJGL binding of OpenAL.  For more information, see http://www.lwjgl.org)
AL lib: (EE) UpdateDeviceParams: Failed to set 44100hz, got 48000hz instead
AL lib: (EE) GetHrtf: Incompatible format: Stereo 48000hz
[19:37:37] [Thread-5/INFO]: OpenAL initialized.
[19:37:37] [Sound Library Loader/INFO]: Sound engine started
[19:37:39] [main/INFO] [FML]: Max texture size: 16384
[19:37:40] [main/INFO]: Created: 512x512 textures-atlas
[19:37:41] [main/INFO] [FML]: Injecting itemstacks
[19:37:41] [main/INFO] [FML]: Itemstack injection complete
[19:37:41] [main/INFO]: [STDOUT]: Post Init
[19:37:41] [main/INFO] [FML]: Forge Mod Loader has successfully loaded 5 mods
[19:37:41] [main/WARN]: Skipping bad option: lastServer:
[19:37:41] [main/INFO]: Narrator library for x64 successfully loaded
[19:37:42] [Realms Notification Availability checker #1/INFO]: Could not authorize you against Realms server: Invalid session id
[19:38:11] [Server thread/INFO]: Starting integrated minecraft server version 1.12
[19:38:11] [Server thread/INFO]: Generating keypair
[19:38:11] [Server thread/INFO] [FML]: Injecting existing registry data into this server instance
[19:38:11] [Server thread/INFO] [FML]: Applying holder lookups
[19:38:11] [Server thread/INFO] [FML]: Holder lookups applied
[19:38:12] [Server thread/INFO] [FML]: Loading dimension 0 (Test) (net.minecraft.server.integrated.IntegratedServer@84a45ec)
[19:38:12] [Server thread/INFO]: Loaded 488 advancements
[19:38:12] [Server thread/INFO] [FML]: Loading dimension 1 (Test) (net.minecraft.server.integrated.IntegratedServer@84a45ec)
[19:38:12] [Server thread/INFO] [FML]: Loading dimension -1 (Test) (net.minecraft.server.integrated.IntegratedServer@84a45ec)
[19:38:12] [Server thread/INFO]: Preparing start region for level 0
[19:38:13] [Server thread/INFO]: Changing view distance to 12, from 10
[19:38:14] [Netty Local Client IO #0/INFO] [FML]: Server protocol version 2
[19:38:14] [Netty Server IO #1/INFO] [FML]: Client protocol version 2
[19:38:14] [Netty Server IO #1/INFO] [FML]: Client attempting to join with 5 mods : [email protected],[email protected],[email protected],[email protected],[email protected]
[19:38:14] [Netty Local Client IO #0/INFO] [FML]: [Netty Local Client IO #0] Client side modded connection established
[19:38:14] [Server thread/INFO] [FML]: [Server thread] Server side modded connection established
[19:38:14] [Server thread/INFO]: Player211[local:E:87ea23f0] logged in with entity id 371 at (-170.95431362535186, 99.37606026508846, 270.316685203002)
[19:38:14] [Server thread/INFO]: Player211 joined the game
[19:38:15] [Server thread/INFO]: Saving and pausing game...
[19:38:15] [Server thread/INFO]: Saving chunks for level 'Test'/overworld
[19:38:15] [Server thread/INFO]: Saving chunks for level 'Test'/the_nether
[19:38:15] [Server thread/INFO]: Saving chunks for level 'Test'/the_end
[19:38:15] [pool-2-thread-1/WARN]: Couldn't look up profile properties for com.mojang.authlib.GameProfile@7f407301[id=da0854f1-946e-3e92-942a-afd6fa88ef77,name=Player211,properties={},legacy=false]
com.mojang.authlib.exceptions.AuthenticationException: The client has sent too many requests within a certain amount of time
	at com.mojang.authlib.yggdrasil.YggdrasilAuthenticationService.makeRequest(YggdrasilAuthenticationService.java:79) ~[YggdrasilAuthenticationService.class:?]
	at com.mojang.authlib.yggdrasil.YggdrasilMinecraftSessionService.fillGameProfile(YggdrasilMinecraftSessionService.java:180) [YggdrasilMinecraftSessionService.class:?]
	at com.mojang.authlib.yggdrasil.YggdrasilMinecraftSessionService$1.load(YggdrasilMinecraftSessionService.java:60) [YggdrasilMinecraftSessionService$1.class:?]
	at com.mojang.authlib.yggdrasil.YggdrasilMinecraftSessionService$1.load(YggdrasilMinecraftSessionService.java:57) [YggdrasilMinecraftSessionService$1.class:?]
	at com.google.common.cache.LocalCache$LoadingValueReference.loadFuture(LocalCache.java:3716) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$Segment.loadSync(LocalCache.java:2424) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$Segment.lockedGetOrLoad(LocalCache.java:2298) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$Segment.get(LocalCache.java:2211) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache.get(LocalCache.java:4154) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache.getOrLoad(LocalCache.java:4158) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$LocalLoadingCache.get(LocalCache.java:5147) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$LocalLoadingCache.getUnchecked(LocalCache.java:5153) [guava-21.0.jar:?]
	at com.mojang.authlib.yggdrasil.YggdrasilMinecraftSessionService.fillProfileProperties(YggdrasilMinecraftSessionService.java:170) [YggdrasilMinecraftSessionService.class:?]
	at net.minecraft.client.Minecraft.getProfileProperties(Minecraft.java:3156) [Minecraft.class:?]
	at net.minecraft.client.resources.SkinManager$3.run(SkinManager.java:138) [SkinManager$3.class:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) [?:1.8.0_144]
	at java.util.concurrent.FutureTask.run(Unknown Source) [?:1.8.0_144]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:1.8.0_144]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:1.8.0_144]
	at java.lang.Thread.run(Unknown Source) [?:1.8.0_144]
[19:38:26] [Server thread/INFO]: Saving and pausing game...
[19:38:26] [Server thread/INFO]: Saving chunks for level 'Test'/overworld
[19:38:26] [Server thread/INFO]: Saving chunks for level 'Test'/the_nether
[19:38:26] [Server thread/INFO]: Saving chunks for level 'Test'/the_end

 

 

 

Thanks in advance,

~ Squishling

[Draco18s]

You need to use the registry events. Models need to be registered (exactly as you have) but in the ModelRegistryEvent

[Squishling]

11 hours ago, Draco18s said:

You need to use the registry events. Models need to be registered (exactly as you have) but in the ModelRegistryEvent

Thanks.  Will try this tomorrow (in ~20 hrs).  This sounds like a very logical soloution.

 

EDIT: I tried it now, and I still have the same problem.  Code used:

    package co.uk.squishling.TestMod.registry;

    import co.uk.squishling.TestMod.init.ModItems;
    import net.minecraftforge.client.event.ModelRegistryEvent;
    import net.minecraftforge.fml.common.Mod.EventBusSubscriber;
    import net.minecraftforge.fml.common.eventhandler.SubscribeEvent;

    @EventBusSubscriber

    public class ModelRegistry {
        @SubscribeEvent    
        public void register(ModelRegistryEvent event) {
            ModItems.registerRenders();
        }
    }

 

Edited October 16, 2017 by Squishling
Code edit

[Draco18s]

Your method needs to be static.

[Squishling]

@Draco18s sorry to be a nag, but now it is displaying as the text

Quote

stestmod:packet#inventor

y

Over a black and pink box.

I think it might be something to do with it not loading my model file?

 

EDIT: This is my model file:

    {

        "parent": "item/generated",

        "textures": {

            "layer0": "stestmod:items/packet"

        }

    }

Edited October 16, 2017 by Squishling
Edit

[Jay Avery]

Post the whole log.

[Squishling]

@Jay Avery The console log?

Spoiler

2017-10-16 07:18:25,576 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
2017-10-16 07:18:25,578 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
[07:18:25] [main/INFO] [GradleStart]: Extra: []
[07:18:25] [main/INFO] [GradleStart]: Running with arguments: [--userProperties, {}, --assetsDir, C:/Users/Vive/.gradle/caches/minecraft/assets, --assetIndex, 1.12, --accessToken{REDACTED}, --version, 1.12, --tweakClass, net.minecraftforge.fml.common.launcher.FMLTweaker, --tweakClass, net.minecraftforge.gradle.tweakers.CoremodTweaker]
[07:18:25] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.FMLTweaker
[07:18:25] [main/INFO] [LaunchWrapper]: Using primary tweak class name net.minecraftforge.fml.common.launcher.FMLTweaker
[07:18:25] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.gradle.tweakers.CoremodTweaker
[07:18:25] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLTweaker
[07:18:25] [main/INFO] [FML]: Forge Mod Loader version 14.21.1.2387 for Minecraft 1.12 loading
[07:18:25] [main/INFO] [FML]: Java is Java HotSpot(TM) 64-Bit Server VM, version 1.8.0_144, running on Windows 10:amd64:10.0, installed at C:\Program Files\Java\jre1.8.0_144
[07:18:25] [main/INFO] [FML]: Managed to load a deobfuscated Minecraft name- we are in a deobfuscated environment. Skipping runtime deobfuscation
[07:18:25] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.gradle.tweakers.CoremodTweaker
[07:18:25] [main/INFO] [GradleStart]: Injecting location in coremod net.minecraftforge.fml.relauncher.FMLCorePlugin
[07:18:25] [main/INFO] [GradleStart]: Injecting location in coremod net.minecraftforge.classloading.FMLForgePlugin
[07:18:25] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.FMLInjectionAndSortingTweaker
[07:18:25] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.FMLDeobfTweaker
[07:18:25] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.gradle.tweakers.AccessTransformerTweaker
[07:18:25] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLInjectionAndSortingTweaker
[07:18:25] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLInjectionAndSortingTweaker
[07:18:25] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.relauncher.CoreModManager$FMLPluginWrapper
2017-10-16 07:18:25,907 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
2017-10-16 07:18:26,108 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
2017-10-16 07:18:26,109 main WARN Unable to instantiate org.fusesource.jansi.WindowsAnsiOutputStream
[07:18:26] [main/ERROR] [FML]: The binary patch set is missing. Either you are in a development environment, or things are not going to work!
[07:18:26] [main/ERROR] [FML]: FML appears to be missing any signature data. This is not a good thing
[07:18:26] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.relauncher.CoreModManager$FMLPluginWrapper
[07:18:26] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.FMLDeobfTweaker
[07:18:27] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.gradle.tweakers.AccessTransformerTweaker
[07:18:27] [main/INFO] [LaunchWrapper]: Loading tweak class name net.minecraftforge.fml.common.launcher.TerminalTweaker
[07:18:27] [main/INFO] [LaunchWrapper]: Calling tweak class net.minecraftforge.fml.common.launcher.TerminalTweaker
[07:18:27] [main/INFO] [LaunchWrapper]: Launching wrapped minecraft {net.minecraft.client.main.Main}
[07:18:27] [main/INFO]: Setting user: Player14
[07:18:30] [main/WARN]: Skipping bad option: lastServer:
[07:18:30] [main/INFO]: LWJGL Version: 2.9.4
[07:18:31] [main/INFO] [FML]: -- System Details --
Details:
	Minecraft Version: 1.12
	Operating System: Windows 10 (amd64) version 10.0
	Java Version: 1.8.0_144, Oracle Corporation
	Java VM Version: Java HotSpot(TM) 64-Bit Server VM (mixed mode), Oracle Corporation
	Memory: 785783128 bytes (749 MB) / 1037959168 bytes (989 MB) up to 1037959168 bytes (989 MB)
	JVM Flags: 3 total; -Xincgc -Xmx1024M -Xms1024M
	IntCache: cache: 0, tcache: 0, allocated: 0, tallocated: 0
	FML: 
	Loaded coremods (and transformers): 
	GL info: ' Vendor: 'NVIDIA Corporation' Version: '4.5.0 NVIDIA 382.53' Renderer: 'GeForce GTX 980/PCIe/SSE2'
[07:18:31] [main/INFO] [FML]: MinecraftForge v14.21.1.2387 Initialized
[07:18:31] [main/INFO] [FML]: Replaced 921 ore ingredients
[07:18:32] [main/INFO] [FML]: Found 0 mods from the command line. Injecting into mod discoverer
[07:18:32] [main/INFO] [FML]: Searching C:\Users\Vive\Desktop\Forge\run\mods for mods
[07:18:32] [main/INFO] [FML]: Forge Mod Loader has identified 5 mods to load
[07:18:33] [main/INFO] [FML]: Attempting connection with missing mods [minecraft, mcp, FML, forge, stestmod] at CLIENT
[07:18:33] [main/INFO] [FML]: Attempting connection with missing mods [minecraft, mcp, FML, forge, stestmod] at SERVER
[07:18:33] [main/INFO]: Reloading ResourceManager: Default, FMLFileResourcePack:Forge Mod Loader, FMLFileResourcePack:Minecraft Forge, FMLFileResourcePack:STestMod
[07:18:33] [main/INFO] [FML]: Processing ObjectHolder annotations
[07:18:33] [main/INFO] [FML]: Found 1168 ObjectHolder annotations
[07:18:33] [main/INFO] [FML]: Identifying ItemStackHolder annotations
[07:18:33] [main/INFO] [FML]: Found 0 ItemStackHolder annotations
[07:18:33] [main/INFO] [FML]: Configured a dormant chunk cache size of 0
[07:18:33] [Forge Version Check/INFO] [ForgeVersionCheck]: [forge] Starting version check at http://files.minecraftforge.net/maven/net/minecraftforge/forge/promotions_slim.json
[07:18:33] [main/INFO] [FML]: Applying holder lookups
[07:18:33] [main/INFO] [FML]: Holder lookups applied
[07:18:33] [main/INFO] [FML]: Applying holder lookups
[07:18:33] [main/INFO] [FML]: Holder lookups applied
[07:18:33] [main/INFO] [FML]: Applying holder lookups
[07:18:33] [main/INFO] [FML]: Holder lookups applied
[07:18:33] [main/INFO] [FML]: Applying holder lookups
[07:18:33] [main/INFO] [FML]: Holder lookups applied
[07:18:33] [main/INFO] [FML]: Injecting itemstacks
[07:18:33] [main/INFO] [FML]: Itemstack injection complete
[07:18:33] [Forge Version Check/INFO] [ForgeVersionCheck]: [forge] Found status: UP_TO_DATE Target: null
[07:18:34] [Thread-3/INFO] [FML]: Using sync timing. 200 frames of Display.update took 57886739 nanos
[07:18:35] [Sound Library Loader/INFO]: Starting up SoundSystem...
[07:18:35] [Thread-5/INFO]: Initializing LWJGL OpenAL
[07:18:35] [Thread-5/INFO]: (The LWJGL binding of OpenAL.  For more information, see http://www.lwjgl.org)
AL lib: (EE) UpdateDeviceParams: Failed to set 44100hz, got 48000hz instead
AL lib: (EE) GetHrtf: Incompatible format: Stereo 48000hz
[07:18:35] [Thread-5/INFO]: OpenAL initialized.
[07:18:35] [Sound Library Loader/INFO]: Sound engine started
[07:18:38] [main/INFO] [FML]: Max texture size: 16384
[07:18:38] [main/INFO]: Created: 512x512 textures-atlas
[07:18:39] [main/INFO] [FML]: Injecting itemstacks
[07:18:39] [main/INFO] [FML]: Itemstack injection complete
[07:18:39] [main/INFO]: [STDOUT]: Post Init
[07:18:39] [main/INFO] [FML]: Forge Mod Loader has successfully loaded 5 mods
[07:18:39] [main/WARN]: Skipping bad option: lastServer:
[07:18:39] [main/INFO]: Narrator library for x64 successfully loaded
[07:18:40] [Realms Notification Availability checker #1/INFO]: Could not authorize you against Realms server: Invalid session id
[07:19:07] [Server thread/INFO]: Starting integrated minecraft server version 1.12
[07:19:07] [Server thread/INFO]: Generating keypair
[07:19:07] [Server thread/INFO] [FML]: Injecting existing registry data into this server instance
[07:19:07] [Server thread/INFO] [FML]: Applying holder lookups
[07:19:07] [Server thread/INFO] [FML]: Holder lookups applied
[07:19:07] [Server thread/INFO] [FML]: Loading dimension 0 (Test) (net.minecraft.server.integrated.IntegratedServer@3172300)
[07:19:08] [Server thread/INFO]: Loaded 488 advancements
[07:19:08] [Server thread/INFO] [FML]: Loading dimension 1 (Test) (net.minecraft.server.integrated.IntegratedServer@3172300)
[07:19:08] [Server thread/INFO] [FML]: Loading dimension -1 (Test) (net.minecraft.server.integrated.IntegratedServer@3172300)
[07:19:08] [Server thread/INFO]: Preparing start region for level 0
[07:19:09] [Server thread/INFO]: Changing view distance to 12, from 10
[07:19:10] [Netty Local Client IO #0/INFO] [FML]: Server protocol version 2
[07:19:10] [Netty Server IO #1/INFO] [FML]: Client protocol version 2
[07:19:10] [Netty Server IO #1/INFO] [FML]: Client attempting to join with 5 mods : [email protected],stestmod@Release v1.0,[email protected],[email protected],[email protected]
[07:19:10] [Netty Local Client IO #0/INFO] [FML]: [Netty Local Client IO #0] Client side modded connection established
[07:19:10] [Server thread/INFO] [FML]: [Server thread] Server side modded connection established
[07:19:10] [Server thread/INFO]: Player14[local:E:541baa4c] logged in with entity id 353 at (-142.6770785028193, 76.50848543089656, 266.6609630620468)
[07:19:10] [Server thread/INFO]: Player14 joined the game
[07:19:11] [Server thread/INFO]: Saving and pausing game...
[07:19:11] [Server thread/INFO]: Saving chunks for level 'Test'/overworld
[07:19:11] [main/INFO]: Loaded 5 advancements
[07:19:11] [Server thread/INFO]: Saving chunks for level 'Test'/the_nether
[07:19:11] [Server thread/INFO]: Saving chunks for level 'Test'/the_end
[07:19:11] [pool-2-thread-1/WARN]: Couldn't look up profile properties for com.mojang.authlib.GameProfile@2542bd2e[id=9a9311e6-0e2a-3db9-849c-c74b23116910,name=Player14,properties={},legacy=false]
com.mojang.authlib.exceptions.AuthenticationException: The client has sent too many requests within a certain amount of time
	at com.mojang.authlib.yggdrasil.YggdrasilAuthenticationService.makeRequest(YggdrasilAuthenticationService.java:79) ~[YggdrasilAuthenticationService.class:?]
	at com.mojang.authlib.yggdrasil.YggdrasilMinecraftSessionService.fillGameProfile(YggdrasilMinecraftSessionService.java:180) [YggdrasilMinecraftSessionService.class:?]
	at com.mojang.authlib.yggdrasil.YggdrasilMinecraftSessionService$1.load(YggdrasilMinecraftSessionService.java:60) [YggdrasilMinecraftSessionService$1.class:?]
	at com.mojang.authlib.yggdrasil.YggdrasilMinecraftSessionService$1.load(YggdrasilMinecraftSessionService.java:57) [YggdrasilMinecraftSessionService$1.class:?]
	at com.google.common.cache.LocalCache$LoadingValueReference.loadFuture(LocalCache.java:3716) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$Segment.loadSync(LocalCache.java:2424) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$Segment.lockedGetOrLoad(LocalCache.java:2298) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$Segment.get(LocalCache.java:2211) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache.get(LocalCache.java:4154) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache.getOrLoad(LocalCache.java:4158) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$LocalLoadingCache.get(LocalCache.java:5147) [guava-21.0.jar:?]
	at com.google.common.cache.LocalCache$LocalLoadingCache.getUnchecked(LocalCache.java:5153) [guava-21.0.jar:?]
	at com.mojang.authlib.yggdrasil.YggdrasilMinecraftSessionService.fillProfileProperties(YggdrasilMinecraftSessionService.java:170) [YggdrasilMinecraftSessionService.class:?]
	at net.minecraft.client.Minecraft.getProfileProperties(Minecraft.java:3156) [Minecraft.class:?]
	at net.minecraft.client.resources.SkinManager$3.run(SkinManager.java:138) [SkinManager$3.class:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source) [?:1.8.0_144]
	at java.util.concurrent.FutureTask.run(Unknown Source) [?:1.8.0_144]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source) [?:1.8.0_144]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source) [?:1.8.0_144]
	at java.lang.Thread.run(Unknown Source) [?:1.8.0_144]
[07:19:35] [Server thread/INFO]: Saving and pausing game...
[07:19:35] [Server thread/INFO]: Saving chunks for level 'Test'/overworld
[07:19:35] [Server thread/INFO]: Saving chunks for level 'Test'/the_nether
[07:19:35] [Server thread/INFO]: Saving chunks for level 'Test'/the_end
[07:19:38] [main/INFO]: [CHAT] Saved screenshot as 2017-10-16_07.19.38.png
[07:19:56] [main/INFO]: Stopping!
[07:19:56] [Server thread/INFO]: Stopping server
[07:19:56] [Server thread/INFO]: Saving players
[07:19:56] [Server thread/INFO]: Saving worlds
[07:19:56] [Server thread/INFO]: Saving chunks for level 'Test'/overworld
[07:19:56] [Server thread/INFO]: Saving chunks for level 'Test'/the_nether
[07:19:56] [Server thread/INFO]: Saving chunks for level 'Test'/the_end
[07:19:56] [Server thread/INFO] [FML]: Unloading dimension 0
[07:19:56] [Server thread/INFO] [FML]: Unloading dimension -1
[07:19:56] [Server thread/INFO] [FML]: Unloading dimension 1
[07:19:56] [main/INFO]: SoundSystem shutting down...
[07:19:56] [Server thread/INFO] [FML]: Applying holder lookups
[07:19:56] [Server thread/INFO] [FML]: Holder lookups applied
[07:19:57] [main/WARN]: Author: Paul Lamb, www.paulscode.com
Java HotSpot(TM) 64-Bit Server VM warning: Using incremental CMS is deprecated and will likely be removed in a future release