Log slow grist cost generator item lookups

CHANGELOG.md

@@ -6,6 +6,10 @@ The format is based on [Keep a Changelog](https://keepachangelog.com/en/1.1.0/).
 
 ## [Unreleased]
 
+### Fixed
+
+- More logging for grist cost generator to help identify bottlenecks
+
 ## [1.20.1-1.12.0.0] - 2024-04-13
 
 ### Added

src/main/java/com/mraof/minestuck/alchemy/recipe/generator/GristCostGenerator.java

@@ -3,8 +3,8 @@
 import com.mraof.minestuck.Minestuck;
 import com.mraof.minestuck.MinestuckConfig;
 import com.mraof.minestuck.api.alchemy.GristSet;
-import com.mraof.minestuck.api.alchemy.recipe.generator.GeneratedCostProvider;
 import com.mraof.minestuck.api.alchemy.recipe.GristCostRecipe;
+import com.mraof.minestuck.api.alchemy.recipe.generator.GeneratedCostProvider;
 import com.mraof.minestuck.api.alchemy.recipe.generator.GristCostResult;
 import it.unimi.dsi.fastutil.objects.Object2IntMap;
 import it.unimi.dsi.fastutil.objects.Object2IntOpenHashMap;
@@ -80,9 +80,15 @@ private static void run(RecipeManager recipes)
 		//Iterate through items
 		process.providersByItem.keySet().stream()
 				.sorted(Comparator.comparingInt(item -> -lookupCount.getInt(item)))
-				.forEach(item ->
-						lookupCost(process, new GenerationContext(item, (context1) -> lookupCost(process, context1)))
-				);
+				.forEach(item -> {
+					long itemStartTime = System.currentTimeMillis();
+
+					lookupCost(process, new GenerationContext(item, (context1) -> lookupCost(process, context1)));
+
+					double itemTime = (System.currentTimeMillis() - itemStartTime)/1000D;
+					if(itemTime > 0.5)
+						LOGGER.warn("Cost generation for {} took {}s", ForgeRegistries.ITEMS.getKey(item), itemTime);
+				});
 
 		for(GeneratedCostProvider provider : process.providers)
 		{
@@ -95,7 +101,7 @@ private static void run(RecipeManager recipes)
 			}
 		}
 
-		LOGGER.debug("Finished grist cost generation in {}s", (System.currentTimeMillis() - startTime)/1000D);
+		LOGGER.info("Finished grist cost generation in {}s", (System.currentTimeMillis() - startTime)/1000D);
 	}
 
 	private static GristSet lookupCost(GeneratorProcess process, GenerationContext context)