INFO 2023-08-10 22:01:23.666 [main] engine.gameManager.ConfigManager.init(114) : Loading config from environment... INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_BIND_ADDR:172.17.0.2 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_EXTERNAL_ADDR:0.0.0.0 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_DATABASE_ADDRESS:localhost INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_DATABASE_PORT:3306 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_DATABASE_NAME:magicbane INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_DATABASE_USER:magicbox INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_DATABASE_PASS:ArtyomWasHere INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_WAREHOUSE_ADDR:0.0.0.0 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_WAREHOUSE_USER:forumuser INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_WAREHOUSE_PASS:forumpass INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_LOGIN_PORT:6000 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_LOGIN_AUTOREG:TRUE INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_LOGIN_FNAME_REGEX:^[A-Za-z]+$ INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_MAJOR_VER:1.2.26.0 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_MINOR_VER:5.26.0 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_WORLD_NAME:MagicBox INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_WORLD_MAPID:162 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_WORLD_REALMMAP:3000002 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_WORLD_PORT:8000 INFO 2023-08-10 22:01:23.667 [main] engine.gameManager.ConfigManager.init(118) : MB_WORLD_ACCESS_LVL:ACTIVE INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_WORLD_WAREHOUSE_PUSH:false INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_WORLD_MAINTENANCE:false INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_WORLD_GREETING:Welcome to Shadowbane INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_WORLD_KEYCLONE_MAX:4 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_USE_RUINS:false INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_AI_CAST_FREQUENCY:1.0 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_AI_AGGRO_RANGE:1.0 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_NORMAL_EXP_RATE:1.0 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_NORMAL_DROP_RATE:1.0 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_NORMAL_GOLD_RATE:1.0 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_HOTZONE_EXP_RATE:2.0 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_HOTZONE_DROP_RATE:2.0 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_HOTZONE_GOLD_RATE:2.0 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_HOTZONE_DURATION:2 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_HOTZONE_MIN_LEVEL:10 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_PRODUCTION_RATE:0.5 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_SERVERID:8675309 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_BOTTOKEN:8675309 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_ROLEID:8675309 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_ANNOUNCE:8675309 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_SEPTIC:8675309 INFO 2023-08-10 22:01:23.668 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_CHANGELOG:8675309 INFO 2023-08-10 22:01:23.669 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_POLITICAL:8675309 INFO 2023-08-10 22:01:23.669 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_GENERAL:8675309 INFO 2023-08-10 22:01:23.669 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_FORTOFIX:8675309 INFO 2023-08-10 22:01:23.669 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_RECRUIT:8675309 INFO 2023-08-10 22:01:23.669 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_MAGICBOX:8675309 INFO 2023-08-10 22:01:23.669 [main] engine.gameManager.ConfigManager.init(118) : MB_MAGICBOT_ADMINLOG:8675309 INFO 2023-08-10 22:01:23.669 [main] engine.gameManager.ConfigManager.init(128) : Compiling regex INFO 2023-08-10 22:01:23.699 [main] engine.server.world.WorldServer.init(291) : MAGICBANE SERVER GREETING: INFO 2023-08-10 22:01:23.699 [main] engine.server.world.WorldServer.init(292) : Welcome to Shadowbane INFO 2023-08-10 22:01:23.699 [main] engine.server.world.WorldServer.init(294) : Initialize network protocol INFO 2023-08-10 22:01:23.888 [main] engine.server.world.WorldServer.init(297) : Initialize database layer INFO 2023-08-10 22:01:23.888 [main] engine.server.world.WorldServer.initDatabaselayer(518) : Configuring GameObjectManager to use Database: 'magicbane' on localhost:3306 [main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting... [main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed. INFO 2023-08-10 22:01:25.161 [main] engine.gameManager.DbManager.configureConnectionPool(325) : Database configured with 16 connections INFO 2023-08-10 22:01:25.170 [main] engine.server.world.WorldServer.init(300) : Starting network Dispatcher INFO 2023-08-10 22:01:25.174 [main] engine.net.MessageDispatcher.(60) : Dispatcher thread has started! INFO 2023-08-10 22:01:25.174 [main] engine.server.world.WorldServer.init(303) : Setting cross server session behavior INFO 2023-08-10 22:01:25.179 [main] engine.server.world.WorldServer.init(306) : Starting Item Production thread INFO 2023-08-10 22:01:25.180 [main] engine.server.world.WorldServer.init(309) : Initializing Errant Guild INFO 2023-08-10 22:01:25.183 [main] engine.server.world.WorldServer.init(312) : Initializing PowersManager. INFO 2023-08-10 22:01:26.152 [main] engine.server.world.WorldServer.init(315) : Initializing granted Skills for Runes INFO 2023-08-10 22:01:26.173 [main] engine.server.world.WorldServer.init(318) : Initializing Player Friends INFO 2023-08-10 22:01:26.176 [main] engine.server.world.WorldServer.init(321) : Initializing NPC Profits INFO 2023-08-10 22:01:26.179 [main] engine.server.world.WorldServer.init(324) : Initializing MeshBounds INFO 2023-08-10 22:01:26.185 [main] engine.db.handlers.dbBuildingHandler.LOAD_MESH_BOUNDS(610) : read: 758 cached: 758 INFO 2023-08-10 22:01:26.185 [main] engine.server.world.WorldServer.init(327) : Loading ItemBases INFO 2023-08-10 22:01:36.744 [main] engine.db.handlers.dbItemBaseHandler.LOAD_ALL_ITEMBASES(96) : read: 5094 cached: 5094 INFO 2023-08-10 22:01:36.744 [main] engine.server.world.WorldServer.init(330) : Loading PromotionClasses INFO 2023-08-10 22:01:36.898 [main] engine.server.world.WorldServer.init(333) : Loading NPC and Mob Rune Sets INFO 2023-08-10 22:01:36.932 [main] engine.db.handlers.dbItemBaseHandler.LOAD_RUNES_FOR_NPC_AND_MOBS(134) : read: 6948 cached: 5341 INFO 2023-08-10 22:01:36.937 [main] engine.server.world.WorldServer.init(336) : Loading Booty Sets INFO 2023-08-10 22:01:37.282 [main] engine.db.handlers.dbLootHandler.LOAD_BOOTY_TABLES(220) : read: 22745 cached: 5798 INFO 2023-08-10 22:01:37.283 [main] engine.server.world.WorldServer.init(340) : Initializing Loot Manager INFO 2023-08-10 22:01:37.342 [main] engine.db.handlers.dbLootHandler.LOAD_GEN_ITEM_TABLES(65) : read: 614 cached: 64 INFO 2023-08-10 22:01:37.371 [main] engine.db.handlers.dbLootHandler.LOAD_ITEM_TABLES(104) : read: 3099 cached: 216 INFO 2023-08-10 22:01:37.378 [main] engine.db.handlers.dbLootHandler.LOAD_MOD_TABLES(143) : read: 746 cached: 158 INFO 2023-08-10 22:01:37.398 [main] engine.db.handlers.dbLootHandler.LOAD_MOD_TYPE_TABLES(182) : read: 2771 cached: 264 INFO 2023-08-10 22:01:38.138 [main] engine.db.handlers.dbRuneBaseHandler.LOAD_ALLOWED_STARTING_RUNES_FOR_BASECLASS(138) : read: 97 cached: 5 INFO 2023-08-10 22:01:38.140 [main] engine.db.handlers.dbRuneBaseHandler.LOAD_ALLOWED_STARTING_RUNES_FOR_RACE(176) : read: 324 cached: 23 INFO 2023-08-10 22:01:38.249 [main] engine.db.handlers.dbRaceHandler.LOAD_ALL_RACES(160) : read: 26 cached: 26 INFO 2023-08-10 22:01:38.251 [main] engine.server.world.WorldServer.init(348) : Loading MobBases. INFO 2023-08-10 22:01:39.800 [main] engine.server.world.WorldServer.init(351) : Loading Mob Powers INFO 2023-08-10 22:01:39.865 [main] engine.db.handlers.dbPowerHandler.LOAD_MOB_POWERS(124) : read: 5373 cached: 986 INFO 2023-08-10 22:01:39.865 [main] engine.server.world.WorldServer.init(354) : Loading item enchants INFO 2023-08-10 22:01:39.876 [main] engine.server.world.WorldServer.init(357) : Loading zone extent cache INFO 2023-08-10 22:01:39.881 [main] engine.server.world.WorldServer.init(360) : Loading Realms INFO 2023-08-10 22:01:39.888 [main] engine.db.handlers.dbRealmHandler.LOAD_ALL_REALMS(48) : read: 25 cached: 25 INFO 2023-08-10 22:01:39.888 [main] engine.server.world.WorldServer.init(363) : Loading RealmMap INFO 2023-08-10 22:01:40.048 [main] engine.util.MapLoader.loadMap(71) : Realmmap: mb.data/realmmaps/3000002.png INFO 2023-08-10 22:01:40.048 [main] engine.util.MapLoader.loadMap(72) : 262144 pixels processed in 158 milis INFO 2023-08-10 22:01:40.048 [main] engine.util.MapLoader.loadMap(73) : 46833 realm pixels written INFO 2023-08-10 22:01:40.048 [main] engine.server.world.WorldServer.init(366) : Loading Kits INFO 2023-08-10 22:01:40.052 [main] engine.server.world.WorldServer.init(369) : Loading World Grid INFO 2023-08-10 22:01:40.173 [main] engine.server.world.WorldServer.init(372) : Starting InterestManager. INFO 2023-08-10 22:01:40.174 [main] engine.InterestManagement.InterestManager.(42) : Interest Management thread is running. INFO 2023-08-10 22:01:40.175 [main] engine.server.world.WorldServer.init(375) : Loading blueprint data. INFO 2023-08-10 22:01:40.178 [main] engine.db.handlers.dbBuildingHandler.LOAD_ALL_STATIC_COLLIDERS(645) : read: 258 cached: 23 INFO 2023-08-10 22:01:40.274 [main] engine.db.handlers.dbBuildingHandler.LOAD_BUILDING_REGIONS(585) : read: 4377 cached: 758 INFO 2023-08-10 22:01:40.277 [main] engine.db.handlers.dbBlueprintHandler.LOAD_ALL_DOOR_NUMBERS(45) : read: 426 cached: 426 INFO 2023-08-10 22:01:40.279 [main] engine.db.handlers.dbBlueprintHandler.LOAD_ALL_BLUEPRINTS(82) : read: 168 cached: 168 INFO 2023-08-10 22:01:40.280 [main] engine.server.world.WorldServer.init(381) : Initializing Heightmap data INFO 2023-08-10 22:01:45.851 [main] engine.InterestManagement.HeightMap.loadAlHeightMaps(525) : 179 Heightmaps cached. INFO 2023-08-10 22:01:45.851 [main] engine.server.world.WorldServer.init(384) : Loading Race data INFO 2023-08-10 22:01:45.903 [main] engine.db.handlers.dbRaceHandler.LOAD_ALL_RACES(160) : read: 26 cached: 26 INFO 2023-08-10 22:01:45.904 [main] engine.server.world.WorldServer.init(388) : Loading building slot/stuck location data. INFO 2023-08-10 22:01:46.009 [main] engine.server.world.WorldServer.init(395) : Starting Data Warehouse INFO 2023-08-10 22:01:46.010 [main] engine.db.archive.DataWarehouse.(39) : Warehouse Remote Connection disabled along with push INFO 2023-08-10 22:01:46.011 [main] engine.server.world.WorldServer.init(398) : Loading Minion Bases. INFO 2023-08-10 22:01:46.012 [main] engine.server.world.WorldServer.init(401) : Loading Pirate Names. INFO 2023-08-10 22:01:46.012 [DataWarehouse] engine.db.archive.DataWarehouse.run(222) : DataWarehouse is running. INFO 2023-08-10 22:01:46.060 [main] engine.db.handlers.dbNPCHandler.LOAD_PIRATE_NAMES(302) : names read: 2788 for 24 mobBases INFO 2023-08-10 22:01:46.060 [main] engine.server.world.WorldServer.init(404) : Loading Support Types INFO 2023-08-10 22:01:48.441 [main] engine.objects.City.setParent(642) : Aeldreth Havens created custom heightmap ERROR 2023-08-10 22:01:58.645 [main] engine.objects.NPC.initializeNPC(800) : No available slot for NPC: 15551 WARNING 2023-08-10 22:01:58.722 [main] engine.objects.MobLoot.generateId(107) : Only 10,000 Id numbers remain useable. Server restart suggested. ERROR 2023-08-10 22:01:58.833 [main] engine.objects.NPC.initializeNPC(800) : No available slot for NPC: 15895 ERROR 2023-08-10 22:01:58.917 [main] engine.objects.NPC.initializeNPC(800) : No available slot for NPC: 16056 INFO 2023-08-10 22:02:05.352 [main] engine.objects.City.setParent(642) : Khan'Ov Srekel created custom heightmap ERROR 2023-08-10 22:02:05.475 [main] engine.objects.NPC.initializeNPC(800) : No available slot for NPC: 31969 INFO 2023-08-10 22:02:07.836 [main] engine.objects.MobLoot.generateId(114) : -20000 of -2147483648 Id numbers consumed. INFO 2023-08-10 22:02:08.102 [main] engine.objects.City.setParent(642) : Perdition created custom heightmap INFO 2023-08-10 22:02:08.165 [main] engine.objects.City.setParent(642) : Bastion created custom heightmap INFO 2023-08-10 22:02:09.742 [main] engine.objects.City.setParent(642) : All-Father's Rest created custom heightmap INFO 2023-08-10 22:02:12.819 [main] engine.objects.MobLoot.generateId(114) : -30000 of -2147483648 Id numbers consumed. INFO 2023-08-10 22:02:12.882 [main] engine.server.world.WorldServer.getWorldBuildingsMobsNPCs(631) : time to load: 25763 ms INFO 2023-08-10 22:02:12.883 [main] engine.server.world.WorldServer.init(414) : Configuring realm serialization data INFO 2023-08-10 22:02:12.883 [main] engine.server.world.WorldServer.init(417) : Loading Mine data. INFO 2023-08-10 22:02:12.904 [main] engine.server.world.WorldServer.init(420) : Loading Shrine data. INFO 2023-08-10 22:02:12.908 [main] engine.server.world.WorldServer.init(423) : Initialize Resource type lookup INFO 2023-08-10 22:02:12.909 [main] engine.server.world.WorldServer.init(426) : Loading Warehouse data. INFO 2023-08-10 22:02:12.911 [main] engine.server.world.WorldServer.init(429) : Loading Runegate data. INFO 2023-08-10 22:02:12.927 [main] engine.server.world.WorldServer.init(432) : Loading Max Skills for Trainers INFO 2023-08-10 22:02:12.958 [main] engine.server.world.WorldServer.init(438) : Loading All Players from database to Server Cache INFO 2023-08-10 22:02:13.019 [main] engine.server.world.WorldServer.init(449) : Loading All Players took 61 ms. INFO 2023-08-10 22:02:13.020 [main] engine.server.world.WorldServer.init(453) : Loading Player Heraldries INFO 2023-08-10 22:02:13.035 [main] engine.server.world.WorldServer.init(456) : Running Heraldry Audit for Deleted Players INFO 2023-08-10 22:02:13.036 [main] engine.server.world.WorldServer.init(460) : Starting Mob AI Thread INFO 2023-08-10 22:02:13.036 [main] engine.mobileAI.Threads.MobAIThread.(20) : MobAIThread thread has started! INFO 2023-08-10 22:02:13.037 [main] engine.server.world.WorldServer.init(471) : World data loaded. INFO 2023-08-10 22:02:13.037 [main] engine.server.world.WorldServer.init(475) : Default access level set to ACTIVE INFO 2023-08-10 22:02:13.037 [main] engine.server.world.WorldServer.init(477) : Initializing Network INFO 2023-08-10 22:02:13.100 [main] engine.server.world.WorldServer.init(480) : Initializing Client Connection Manager INFO 2023-08-10 22:02:13.100 [main] engine.server.world.WorldServer.initClientConnectionManager(257) : AUTOCONFIG EXTERNAL IP ADDRESS INFO 2023-08-10 22:02:13.580 [main] engine.server.world.WorldServer.initClientConnectionManager(274) : External address: 122.239.240.85:8000 INFO 2023-08-10 22:02:13.580 [main] engine.server.world.WorldServer.initClientConnectionManager(275) : Internal address: 172.17.0.2:6000 INFO 2023-08-10 22:02:13.591 [main] engine.net.AbstractConnectionManager.(54) : MagicBox.ClientConnMan Configured to listen: /172.17.0.2:8000 INFO 2023-08-10 22:02:13.595 [main] engine.server.world.WorldServer.init(484) : Starting Mob Respawn Thread INFO 2023-08-10 22:02:13.598 [main] engine.mobileAI.Threads.MobRespawnThread.(33) : MobRespawnThread thread has started! INFO 2023-08-10 22:02:13.606 [main] engine.gameManager.MaintenanceManager.dailyMaintenance(313) : Maintenance has started INFO 2023-08-10 22:02:13.606 [main] engine.gameManager.MaintenanceManager.dailyMaintenance(320) : Maintenance Costings: DISABLED INFO 2023-08-10 22:02:13.606 [main] engine.gameManager.MaintenanceManager.dailyMaintenance(322) : Maintenance has completed! INFO 2023-08-10 22:02:13.606 [main] engine.server.world.WorldServer.init(491) : Starting Orphan Item Purge INFO 2023-08-10 22:02:13.607 [main] engine.server.world.WorldServer.init(496) : Processing mine window. INFO 2023-08-10 22:02:13.612 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Aedroch Highlands's Mine is now Active! INFO 2023-08-10 22:02:13.625 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Western Battleground's Mine is now Active! INFO 2023-08-10 22:02:13.625 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Aerath Hellendroth's Mine is now Active! INFO 2023-08-10 22:02:13.625 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : The Black Bog's Mine is now Active! INFO 2023-08-10 22:02:13.626 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Valkos Wilds's Mine is now Active! INFO 2023-08-10 22:02:13.626 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Leth'khalivar Desert's Mine is now Active! INFO 2023-08-10 22:02:13.626 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Aurrochs Skrae's Mine is now Active! INFO 2023-08-10 22:02:13.626 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Thollok Marsh's Mine is now Active! INFO 2023-08-10 22:02:13.626 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Jotensgaard's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Fellgrim Forest's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Ecklund Wilds's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Tainted Swamp's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Derros Plains's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Hethland Holm's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : The Doomplain's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Bone Marches's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Ashfell Plain's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Vale of Nar Addad's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Phaedra's Prize's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Grimscairne's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Ragnir Holm's Mine is now Active! INFO 2023-08-10 22:02:13.627 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Sevaath Mere's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Doomhorn Skrae's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Ymur's Crown's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Hregend Wildlands's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Plain of Ashes's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Pandemonium's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : The Blood Sands's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Kralgaar Holm's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Kharsoom's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Southern Battleground's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Aeran Belendor's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Holloch Forest's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Greensward Pyre's Mine is now Active! INFO 2023-08-10 22:02:13.628 [main] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Braedoch Highlands's Mine is now Active! INFO 2023-08-10 22:02:13.668 [main] engine.server.world.WorldServer.init(504) : Bootstrap time was 0 hours 00 minutes 51 seconds INFO 2023-08-10 22:02:13.668 [main] engine.server.world.WorldServer.init(508) : Running garbage collection... WARNING 2023-08-10 22:02:16.189 [InterestManager] engine.InterestManagement.InterestManager.advanceOneSecond(193) : LoadJob took more then one second to complete. INFO 2023-08-10 22:02:16.208 [MagicBox.ClientConnMan] engine.job.JobManager.(51) : Adding JobPool_0 with 4 workers INFO 2023-08-10 22:02:16.209 [MagicBox.ClientConnMan] engine.job.JobManager.(51) : Adding JobPool_1 with 2 workers INFO 2023-08-10 22:02:16.209 [MagicBox.ClientConnMan] engine.job.JobManager.(51) : Adding JobPool_2 with 1 workers INFO 2023-08-10 22:02:16.209 [MagicBox.ClientConnMan] engine.job.JobManager._startup(159) : JM Starting up... INFO 2023-08-10 22:02:16.269 [warehousePush] engine.workthreads.WarehousePushThread.run(346) : WAREHOUSEPUSH DISABLED: EARLY EXIT INFO 2023-08-10 22:02:17.700 [purgeOrphans] engine.workthreads.PurgeOprhans.run(62) : Thread is exiting with 0 items deleted INFO 2023-08-10 22:17:16.316 [warehousePush] engine.workthreads.WarehousePushThread.run(346) : WAREHOUSEPUSH DISABLED: EARLY EXIT INFO 2023-08-10 22:32:16.337 [warehousePush] engine.workthreads.WarehousePushThread.run(346) : WAREHOUSEPUSH DISABLED: EARLY EXIT INFO 2023-08-10 22:47:16.382 [warehousePush] engine.workthreads.WarehousePushThread.run(346) : WAREHOUSEPUSH DISABLED: EARLY EXIT INFO 2023-08-10 23:00:00.220 [hourlyJob] engine.workthreads.HourlyJobThread.run(190) : Hourly job is now running. INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.run(208) : HotZone switched to: Tainted Swamp INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Aedroch Highlands's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Western Battleground's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Aerath Hellendroth's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : The Black Bog's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Valkos Wilds's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Leth'khalivar Desert's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Aurrochs Skrae's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Thollok Marsh's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Jotensgaard's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Fellgrim Forest's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Ecklund Wilds's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Tainted Swamp's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Derros Plains's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Hethland Holm's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : The Doomplain's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Bone Marches's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Ashfell Plain's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Vale of Nar Addad's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Phaedra's Prize's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Grimscairne's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Ragnir Holm's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Sevaath Mere's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Doomhorn Skrae's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Ymur's Crown's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Hregend Wildlands's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Plain of Ashes's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Pandemonium's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : The Blood Sands's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Kralgaar Holm's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Kharsoom's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Southern Battleground's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Aeran Belendor's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Holloch Forest's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Greensward Pyre's Mine is now Active! INFO 2023-08-10 23:00:00.221 [hourlyJob] engine.workthreads.HourlyJobThread.mineWindowOpen(121) : Braedoch Highlands's Mine is now Active! INFO 2023-08-10 23:00:00.222 [hourlyJob] engine.workthreads.HourlyJobThread.run(284) : [LUA_UPTIME()] uptime: 0 hours 57 minutes 47 seconds pop: 0 max pop: 0 INFO 2023-08-10 23:00:00.275 [hourlyJob] engine.workthreads.HourlyJobThread.run(285) : Chars:1 Guilds:13 Cities:0 Rulers:0 INFO 2023-08-10 23:00:00.275 [hourlyJob] engine.workthreads.HourlyJobThread.run(286) : [LUA_NETSTA()] poolSize: 0 Channel: PRIMARY Dispatches: 8108 Messages: 0 maxRecipients: 0 Channel: SECONDARY Dispatches: 0 Messages: 0 maxRecipients: 0 INFO 2023-08-10 23:00:00.275 [hourlyJob] engine.workthreads.HourlyJobThread.run(287) : 0orphaned items deleted INFO 2023-08-10 23:02:16.423 [warehousePush] engine.workthreads.WarehousePushThread.run(346) : WAREHOUSEPUSH DISABLED: EARLY EXIT