EQEmulator Forums - massive Zone Unavalable errors +more

EQEmulator Forums (https://www.eqemulator.org/forums/index.php)

- Support::Windows Servers (https://www.eqemulator.org/forums/forumdisplay.php?f=587)

- - massive Zone Unavalable errors +more (https://www.eqemulator.org/forums/showthread.php?t=24340)

massive Zone Unavalable errors +more

Ok 2 hours ago everyhtign was runing 100% OK
Now I am stack at char select screen and cannot get dymanic zones to autoboot. After so many "zone unavalble" message, the world will eventualy say somethign like " expecting Login got BlaBla instead"
also geting "Expecting OP_SendLoginInfo, got OP_ApproveName" whenever server reject a new char name and get booted to server select

Quote:

---------------------------------------------
[02.08. - 00:51:24] Starting Log: logs/eqemu_debug_world_1256.log
[02.08. - 00:51:24] [WORLD__INIT] Loading server configuration..
[02.08. - 00:51:24] [WORLD__INIT] Log settings loaded from log.ini
[02.08. - 00:51:24] [WORLD__INIT] CURRENT_WORLD_VERSION:EQEMu 0.7.0
[02.08. - 00:51:24] [WORLD__INIT] Connecting to MySQL...
[02.08. - 00:51:24] [WORLD__INIT] Starting HTTP world service...
[02.08. - 00:51:24] [WORLD__HTTP] Loaded mime types from mime.types
[02.08. - 00:51:24] [WORLD__INIT] Loading variables..
[02.08. - 00:51:24] [WORLD__INIT] Loading zones..
[02.08. - 00:51:25] [WORLD__INIT] Clearing groups..
[02.08. - 00:51:25] [WORLD__INIT] Clearing temporary merchant lists..
[02.08. - 00:51:25] [WORLD__INIT] Loading items..
[02.08. - 00:52:06] [WORLD__INIT] Loading guilds..
[02.08. - 00:52:06] [WORLD__INIT] Loading rule set 'default'
[02.08. - 00:52:06] [RULES__CHANGE] Loading rule set 'default' (0)
[02.08. - 00:52:06] [RULES__CHANGE] Set rule GM:MinStatusToZoneAnywhere to value 250
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:MaxLevel to value 100
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:LeaveCorpses to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:LeaveNakedCorpses to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:ExpMultiplier to value 0.2500000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:DeathExpLossLevel to value 25
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:CorpseDecayTimeMS to value 86400000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:AutosaveIntervalS to value 300
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:HPRegenMultiplier to value 100
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:ManaRegenMultiplier to value 100
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:EnduranceRegenMultiplier to value 100
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Guild:MaxMembers to value 2048
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Skills:MaxTrainTradeskills to value 1
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Pets:AttackCommandRange to value 200.0000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule World:ZoneAutobootTimeoutMS to value 120000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule World:ClientKeepaliveTimeoutMS to value 180000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:PetSpellAggroMod to value 100
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:SongAggroMod to value 25
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:SpellAggroMod to value 100
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Combat:BaseCritChance to value 0.0000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Combat:WarBerBaseCritChance to value 0.1000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Combat:BerserkBaseCritChance to value 0.2500000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Combat:NPCBashKickLevel to value 6
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:ConsumptionMultiplier to value 200
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Spells:AutoResistDiff to value 15
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Spells:ResistChance to value 2.0000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Spells:ResistMod to value 0.4000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Spells:PartialHitChance to value 0.7000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Combat:ClientBaseCritChance to value 0.0500000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Zone:NPCGlobalPositionUpdateInterval to value 60000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule NPC:MinorNPCCorpseDecayTimeMS to value 600000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule NPC:MajorNPCCorpseDecayTimeMS to value 1200000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Zone:GraveyardTimeMS to value 1200000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Zone:EnableShadowrest to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Map:FixPathingZWhenLoading to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Map:FixPathingZAtWaypoints to value false
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Map:FixPathingZWhenMoving to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Map:FixPathingZOnSendTo to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Zone:ClientLinkdeadMS to value 600000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule NPC:UseItemBonusesForNonPets to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Map:FixPathingZMaxDeltaSendTo to value 20.0000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Map:FixPathingZMaxDeltaLoading to value 20.0000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Map:FixPathingZMaxDeltaMoving to value 20.0000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Map:FixPathingZMaxDeltaWaypoint to value 20.0000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:HealOnLevel to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:FeignKillsPet to value false
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:ItemManaRegenCap to value 150
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:ItemHealthRegenCap to value 150
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Combat:UseIntervalAC to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Combat:PetAttackMagicLevel to value 30
[02.08. - 00:52:06] [RULES__CHANGE] Set rule NPC:SayPauseTimeInSec to value 10
[02.08. - 00:52:06] [RULES__CHANGE] Set rule NPC:OOCRegen to value 0
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:SmartAggroList to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:SittingAggroMod to value 35
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:MeleeRangeAggroMod to value 20
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:CurrentTargetAggroMod to value 0
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:CriticallyWoundedAggroMod to value 100
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:SlowAggroMod to value 450
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:IncapacitateAggroMod to value 500
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Aggro:MovementImpairAggroMod to value 175
[02.08. - 00:52:06] [RULES__CHANGE] Set rule NPC:BuffFriends to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Character:DeathItemLossLevel to value 100
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Watermap:CheckWaypointsInWaterWhenLoading to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Watermap:CheckForWaterAtWaypoints to value false
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Watermap:CheckForWaterWhenMoving to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Watermap:CheckForWaterOnSendTo to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Watermap:CheckForWaterWhenFishing to value true
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Watermap:FishingRodLength to value 30.0000000000000
[02.08. - 00:52:06] [RULES__CHANGE] Set rule Watermap:FishingLineLength to value 40.0000000000000
[02.08. - 00:52:06] [WORLD__INIT] Loading EQ time of day..
[02.08. - 00:52:07] [WORLD__INIT] Loading launcher list..
[02.08. - 00:52:08] [WORLD__INIT] Reboot zone modes ON
[02.08. - 00:52:09] [WORLD__INIT] Deleted 0 stale player corpses from database
[02.08. - 00:52:09] [WORLD__INIT] Deleted 0 stale player backups from database
[02.08. - 00:52:09] [WORLD__INIT] Zone (TCP) listener started.
[02.08. - 00:52:09] [WORLD__INIT] Client (UDP) listener started.
[02.08. - 00:52:09] [NET__IDENTIFY] Registered patch 6.2
[02.08. - 00:52:10] [NET__IDENTIFY] Registered patch Titanium
[02.08. - 00:52:10] [NET__IDENTIFY] Registered patch Anniversary
[02.08. - 00:52:10] [NET__IDENTIFY] Registered patch Live
[02.08. - 00:52:10] [WORLD__LS] Connecting to login server...
[02.08. - 00:52:10] [WORLD__LS] Connected to Loginserver: eqemulator.net:5998
[02.08. - 00:52:10] [WORLD__LS] Loginserver provided 72.89.185.174 as world address
[02.08. - 00:52:29] [WORLD__ZONE] New TCP connection from 127.0.0.1:3249
[02.08. - 00:52:29] [WORLD__CONSOLE] New launcher from 127.0.0.1:3249
[02.08. - 00:52:29] [WORLD__LAUNCH] Adding pending launcher 1
[02.08. - 00:52:29] [WORLD__LAUNCH] Launcher Identified itself as 'zones'. Loading zone list.
[02.08. - 00:52:29] [WORLD__LAUNCH] Removing pending launcher 1. Adding zones to active list.
[02.08. - 00:52:35] [WORLD__LAUNCH] zones: dynamic_01 reported state STARTED (1 starts)
[02.08. - 00:52:56] [WORLD__LAUNCH] zones: dynamic_02 reported state STARTED (1 starts)
[02.08. - 00:52:58] [WORLD__LAUNCH] zones: dynamic_03 reported state STARTED (1 starts)
[02.08. - 00:53:00] [WORLD__LAUNCH] zones: dynamic_04 reported state STARTED (1 starts)
[02.08. - 00:53:02] [WORLD__LAUNCH] zones: dynamic_05 reported state STARTED (1 starts)
[02.08. - 00:53:04] [WORLD__LAUNCH] zones: dynamic_06 reported state STARTED (1 starts)

part 2 with numerious atempts to autoboot with no success at the end

Quote:

[02.08. - 00:54:35] [WORLD__ZONE] New TCP connection from 127.0.0.1:3256
[02.08. - 00:54:35] [WORLD__ZONE] New TCP connection from 127.0.0.1:3257
[02.08. - 00:54:35] [WORLD__ZONE] New TCP connection from 127.0.0.1:3258
[02.08. - 00:54:35] [WORLD__ZONE] New TCP connection from 127.0.0.1:3259
[02.08. - 00:54:35] [WORLD__ZONE] New TCP connection from 127.0.0.1:3260
[02.08. - 00:54:35] [WORLD__ZONE] New TCP connection from 127.0.0.1:3261
[02.08. - 00:54:35] [WORLD__CONSOLE] New zoneserver #1 from 127.0.0.1:3261
[02.08. - 00:54:35] [WORLD__CONSOLE] New zoneserver #2 from 127.0.0.1:3260
[02.08. - 00:54:35] [WORLD__CONSOLE] New zoneserver #3 from 127.0.0.1:3259
[02.08. - 00:54:35] [WORLD__CONSOLE] New zoneserver #4 from 127.0.0.1:3258
[02.08. - 00:54:35] [WORLD__CONSOLE] New zoneserver #5 from 127.0.0.1:3257
[02.08. - 00:54:35] [WORLD__CONSOLE] New zoneserver #6 from 127.0.0.1:3256
[02.08. - 00:54:36] [WORLD__ZONE] [6] Zone started with name dynamic_04 by launcher zones
[02.08. - 00:54:36] [WORLD__ZONE] [6] Auto zone port configuration. Telling zone to use port 7000
[02.08. - 00:54:36] [WORLD__ZONE] [5] Zone started with name dynamic_03 by launcher zones
[02.08. - 00:54:36] [WORLD__ZONE] [5] Auto zone port configuration. Telling zone to use port 7001
[02.08. - 00:54:36] [WORLD__ZONE] [4] Zone started with name dynamic_02 by launcher zones
[02.08. - 00:54:36] [WORLD__ZONE] [4] Auto zone port configuration. Telling zone to use port 7002
[02.08. - 00:54:36] [WORLD__ZONE] [3] Zone started with name dynamic_01 by launcher zones
[02.08. - 00:54:36] [WORLD__ZONE] [3] Auto zone port configuration. Telling zone to use port 7003
[02.08. - 00:54:36] [WORLD__ZONE] [2] Zone started with name dynamic_05 by launcher zones
[02.08. - 00:54:36] [WORLD__ZONE] [2] Auto zone port configuration. Telling zone to use port 7004
[02.08. - 00:54:36] [WORLD__ZONE] [1] Zone started with name dynamic_06 by launcher zones
[02.08. - 00:54:36] [WORLD__ZONE] [1] Auto zone port configuration. Telling zone to use port 7005
[02.08. - 00:59:37] [WORLD__CLIENT] New connection from 192.168.1.136:3265
[02.08. - 00:59:37] [NET__IDENT_TRACE] 192.168.1.136:3265: First opcode 0x4dd0 did not match expected 0x2792
[02.08. - 00:59:37] [NET__IDENT_TRACE] 192.168.1.136:3265: Tried patch 6.2_world, and it did not match.
[02.08. - 00:59:37] [NET__IDENT_TRACE] 192.168.1.136:3265: First opcode 0x4dd0 did not match expected 0x2ec9
[02.08. - 00:59:37] [NET__IDENT_TRACE] 192.168.1.136:3265: Tried patch 6.2_zone, and it did not match.
[02.08. - 00:59:37] [NET__IDENT_TRACE] 192.168.1.136:3265: First opcode matched 0x4dd0 and length matched 464
[02.08. - 00:59:37] [NET__IDENTIFY] Identified stream 192.168.1.136:3265 with signature Titanium_world
[02.08. - 00:59:37] [WORLD__CLIENT] New client from 192.168.1.136:3265
[02.08. - 00:59:37] [WORLD__CLIENT] drakeimperor: Logged in. Mode=(CharSel)
[02.08. - 00:59:37] [WORLD__CLIENT] drakeimperor: LS Account #101724
[02.08. - 01:01:38] [WORLD__CLIENT] drakeimperor: Attempting autobootup of gfaydark (54)
[02.08. - 01:02:14] [WORLD__CLIENT] drakeimperor: Attempting autobootup of gfaydark (54)
[02.08. - 01:02:24] [WORLD__CLIENT] drakeimperor: Attempting autobootup of gfaydark (54)
[02.08. - 01:02:28] [WORLD__CLIENT] drakeimperor: Attempting autobootup of gfaydark (54)
[02.08. - 01:02:32] [WORLD__CLIENT] drakeimperor: Attempting autobootup of gfaydark (54)
[02.08. - 01:15:45] [WORLD__CLIENT_ERR] NOCLE: Expecting OP_SendLoginInfo, got OP_EnterWorld
[02.08. - 01:16:30] [WORLD__CLIENT] New connection from 192.168.1.136:3288
[02.08. - 01:16:30] [NET__IDENT_TRACE] 192.168.1.136:3288: First opcode 0x4dd0 did not match expected 0x2792
[02.08. - 01:16:31] [NET__IDENT_TRACE] 192.168.1.136:3288: Tried patch 6.2_world, and it did not match.
[02.08. - 01:16:31] [NET__IDENT_TRACE] 192.168.1.136:3288: First opcode 0x4dd0 did not match expected 0x2ec9
[02.08. - 01:16:31] [NET__IDENT_TRACE] 192.168.1.136:3288: Tried patch 6.2_zone, and it did not match.
[02.08. - 01:16:31] [NET__IDENT_TRACE] 192.168.1.136:3288: First opcode matched 0x4dd0 and length matched 464
[02.08. - 01:16:31] [NET__IDENTIFY] Identified stream 192.168.1.136:3288 with signature Titanium_world
[02.08. - 01:16:31] [WORLD__CLIENT] New client from 192.168.1.136:3288
[02.08. - 01:16:31] [WORLD__CLIENT] drakeimperor: Logged in. Mode=(CharSel)
[02.08. - 01:16:31] [WORLD__CLIENT] drakeimperor: LS Account #101724
[02.08. - 01:19:27] [WORLD__CLIENT] drakeimperor: Attempting autobootup of gfaydark (54)
[02.08. - 01:20:17] [WORLD__CLIENT] drakeimperor: Attempting autobootup of gfaydark (54)

ok found something what could be interesting, and prety much cuases the error, however I am at a loos how to fix it.
Apparetnly it desperatly looking for specific spawn2 ID which however is not used in any other table. I am not mySQl expert - but the local IDs of spawn2 table are mapping to anywhere? Is there a pattern to this numbers?
I was under impression they could be deleted at will or changed.

Quote:

---------------------------------------------
[02.08. - 01:45:18] Starting Log: logs/eqemu_error_zone_2212.log
[02.08. - 01:45:18] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:45:18] Loading zone state failed.
[02.08. - 01:45:32] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:45:32] Loading zone state failed.
[02.08. - 01:45:34] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:45:34] Loading zone state failed.
[02.08. - 01:45:35] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:45:35] Loading zone state failed.
[02.08. - 01:45:36] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:45:36] Loading zone state failed.
[02.08. - 01:45:37] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:45:37] Loading zone state failed.
[02.08. - 01:45:39] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:45:39] Loading zone state failed.
[02.08. - 01:45:40] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:45:40] Loading zone state failed.
[02.08. - 01:46:14] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:46:14] Loading zone state failed.
[02.08. - 01:46:16] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:46:16] Loading zone state failed.
[02.08. - 01:47:48] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=332456':
[02.08. - 01:47:48] Loading zone state failed.
[02.08. - 01:48:34] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=16451159':
[02.08. - 01:48:34] Loading zone state failed.

ok this getting ridiculus I am got a brand new PEQ DB, copied over my own spawn info (spawn2, spawnentry and spawngroup) from my old backedup DB, and I am still getign the same stupid error!

Quote:

---------------------------------------------
[02.09. - 00:56:04] Starting Log: logs/eqemu_error_zone_1244.log
[02.09. - 00:56:04] Error in LoadSpawn2 query 'SELECT id, spawngroupID, x, y, z, heading, respawntime, variance, pathgrid, _condition, cond_value FROM spawn2 WHERE id=332456':
[02.09. - 00:56:04] Loading zone state failed.

I have no idea WHY in the world I woudl get this error if in my original DB these values never existed to begin with.
The program keep trying to pull up something which is not referenced ANYWHERE!

:-x

ok i did some mySQl manual reading - it seesm that problem is with the spawn2 table.

The table is InnoDB type - and from I understand this thing CANNOT BE just backed up, cuase the IDs of the primary key writen into file are not REAL IDs.
And if you EVER do any changes - like delete an entry and then back up the DB And if DB is later restored from backup - the whole thing (since it uses internal index table which is not shown to the user) and discover than enetry that supose to follow does nto exist - the whole thing crashes...

This mayby not very accurate (I am not mySQl expert), but i belive the problem is how to PROPERLY backup spawn2 table which was in any way altered so it will actualy WORK after restore..

Any mySQl experts can help with this????

ok, this cost me a few grey hair (well few hair...), but with little mySQl expert help we solved this one....

PEOPLE!!! If you EVER delete or move ANY values in spawn2 tables using 1090 server build (INCLUDING using GeorgeS spawn editing tool) TURN OFF zone persistant state! Otherwise you will spend next 5 days drawing in error codes.... :cool:

Thanks for sharing!

I spent longer than I should have looking for why the zone was trying to load a spawn with an id in the billions...