Skip to content

Commit

Permalink
HAS break down
Browse files Browse the repository at this point in the history
  • Loading branch information
@ipdae
ipdae committed Jul 25, 2023
1 parent 61482df commit 048bf7a
Showing 1 changed file with 27 additions and 21 deletions.
48 changes: 27 additions & 21 deletions Lib9c/Action/HackAndSlash.cs
View file
Original file line number Diff line number Diff line change
Expand Up @@ -122,7 +122,8 @@ public IAccountStateDelta Execute(

var addressesHex = $"[{signer.ToHex()}, {AvatarAddress.ToHex()}]";
var started = DateTimeOffset.UtcNow;
Log.Verbose("{AddressesHex}HAS exec started", addressesHex);
const string source = "HackAndSlash";
Log.Verbose("{AddressesHex} {Source} HAS exec started", addressesHex, source);

if (ApStoneCount > UsableApStoneCount)
{
Expand Down Expand Up @@ -156,7 +157,7 @@ public IAccountStateDelta Execute(
}

sw.Stop();
Log.Verbose("{AddressesHex}HAS Get AvatarState: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Get AvatarState", sw.ElapsedMilliseconds);

sw.Restart();
var sheets = states.GetSheets(
Expand Down Expand Up @@ -185,7 +186,7 @@ public IAccountStateDelta Execute(
typeof(RuneListSheet),
});
sw.Stop();
Log.Verbose("{AddressesHex}HAS Get Sheets: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Get Sheets", sw.ElapsedMilliseconds);

sw.Restart();
var stakingLevel = 0;
Expand All @@ -199,7 +200,7 @@ public IAccountStateDelta Execute(
}

sw.Stop();
Log.Verbose("{AddressesHex}HAS Check StakeState: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Check StateState", sw.ElapsedMilliseconds);

var worldSheet = sheets.GetSheet<WorldSheet>();
if (!worldSheet.TryGetValue(WorldId, out var worldRow, false))
Expand All @@ -222,7 +223,7 @@ public IAccountStateDelta Execute(
}

sw.Stop();
Log.Verbose("{AddressesHex}HAS Get StageSheet: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Get StageSheet", sw.ElapsedMilliseconds);

sw.Restart();
var worldInformation = avatarState.worldInformation;
Expand Down Expand Up @@ -262,14 +263,14 @@ public IAccountStateDelta Execute(
}

sw.Stop();
Log.Verbose("{AddressesHex}HAS Validate World: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Validate World", sw.ElapsedMilliseconds);

sw.Restart();
var equipmentList = avatarState.ValidateEquipmentsV2(Equipments, blockIndex);
var foodIds = avatarState.ValidateConsumable(Foods, blockIndex);
var costumeIds = avatarState.ValidateCostume(Costumes);
sw.Stop();
Log.Verbose("{AddressesHex}HAS Validate Items: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Validate Items", sw.ElapsedMilliseconds);

var materialItemSheet = sheets.GetSheet<MaterialItemSheet>();
var apPlayCount = TotalPlayCount;
Expand Down Expand Up @@ -312,11 +313,12 @@ public IAccountStateDelta Execute(
}

Log.Verbose(
"{AddressesHex}TotalPlayCount: {TotalPlayCount}, " +
"{AddressesHex} {Source} TotalPlayCount: {TotalPlayCount}, " +
"ApStoneCount: {ApStoneCount}, PlayCount by Ap stone: {ApStonePlayCount}, " +
"Ap cost per 1 play: {MinimumCostAp}, " +
"PlayCount by action point: {ApPlayCount}, Used AP: {UsedAp}",
addressesHex,
source,
TotalPlayCount,
ApStoneCount,
apStonePlayCount,
Expand Down Expand Up @@ -346,12 +348,12 @@ public IAccountStateDelta Execute(
var items = Equipments.Concat(Costumes);
avatarState.EquipItems(items);
sw.Stop();
Log.Verbose("{AddressesHex}HAS Unequip items: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Unequip items", sw.ElapsedMilliseconds);

sw.Restart();
var questSheet = sheets.GetQuestSheet();
sw.Stop();
Log.Verbose("{AddressesHex}HAS GetQuestSheet: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Get QuestSheet", sw.ElapsedMilliseconds);

// Update QuestList only when QuestSheet.Count is greater than QuestList.Count
var questList = avatarState.questList;
Expand All @@ -364,7 +366,7 @@ public IAccountStateDelta Execute(
sheets.GetSheet<QuestItemRewardSheet>(),
sheets.GetSheet<EquipmentItemRecipeSheet>());
sw.Stop();
Log.Verbose("{AddressesHex}HAS Update QuestList: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Update QuestList", sw.ElapsedMilliseconds);
}

sw.Restart();
Expand Down Expand Up @@ -403,7 +405,7 @@ public IAccountStateDelta Execute(
}

sw.Stop();
Log.Verbose("{AddressesHex}HAS Get skillState : {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Get skillState", sw.ElapsedMilliseconds);

sw.Restart();
var worldUnlockSheet = sheets.GetSheet<WorldUnlockSheet>();
Expand Down Expand Up @@ -438,6 +440,8 @@ public IAccountStateDelta Execute(
runeStates.Add(new RuneState(rawRuneState));
}
}
sw.Stop();
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Update slotState", sw.ElapsedMilliseconds);

var stageWaveRow = sheets.GetSheet<StageWaveSheet>()[StageId];
var enemySkillSheet = sheets.GetSheet<EnemySkillSheet>();
Expand Down Expand Up @@ -468,12 +472,12 @@ public IAccountStateDelta Execute(
rewards,
false);
sw.Stop();
Log.Verbose("{AddressesHex}HAS Initialize Simulator: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Initialize Simulator", sw.ElapsedMilliseconds);

sw.Restart();
simulator.Simulate();
sw.Stop();
Log.Verbose("{AddressesHex}HAS Simulator.Simulate(): {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Simulator.Simulate()", sw.ElapsedMilliseconds);

sw.Restart();
if (simulator.Log.IsClear)
Expand All @@ -490,7 +494,7 @@ public IAccountStateDelta Execute(
stageCleared = true;
}
sw.Stop();
Log.Verbose("{AddressesHex}HAS ClearStage: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "ClearStage", sw.ElapsedMilliseconds);
}

sw.Restart();
Expand Down Expand Up @@ -520,10 +524,12 @@ public IAccountStateDelta Execute(

sw.Stop();
Log.Verbose(
"{AddressesHex}Update avatar by simulator({AvatarAddress}); " +
"{AddressesHex} {Source} {Process} by simulator({AvatarAddress}); " +
"worldId: {WorldId}, stageId: {StageId}, result: {Result}, " +
"clearWave: {ClearWave}, totalWave: {TotalWave}",
addressesHex,
source,
"Update avatar",
AvatarAddress,
WorldId,
StageId,
Expand All @@ -533,8 +539,8 @@ public IAccountStateDelta Execute(
);
}
sw.Stop();
Log.Debug("{AddressesHex} {Source} loop Simulate: {Elapsed}, Count: {PlayCount}",
addressesHex, "HackAndSlash", sw.Elapsed, TotalPlayCount);
Log.Debug("{AddressesHex} {Source} {Process}: {Elapsed}, Count: {PlayCount}",
addressesHex, source, "loop Simulate", sw.Elapsed, TotalPlayCount);

// Update CrystalRandomSkillState.Stars by clearedWaveNumber. (add)
skillState?.Update(starCount, crystalStageBuffSheet);
Expand All @@ -543,7 +549,7 @@ public IAccountStateDelta Execute(
avatarState.updatedAt = blockIndex;
avatarState.mailBox.CleanUp();
sw.Stop();
Log.Verbose("{AddressesHex}HAS Update AvatarState: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Update AvatarState", sw.ElapsedMilliseconds);

sw.Restart();
if (isNotClearedStage)
Expand All @@ -565,10 +571,10 @@ public IAccountStateDelta Execute(
.SetState(worldInformationAddress, avatarState.worldInformation.Serialize())
.SetState(questListAddress, avatarState.questList.Serialize());
sw.Stop();
Log.Verbose("{AddressesHex}HAS Set States: {Elapsed}", addressesHex, sw.Elapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Set States", sw.ElapsedMilliseconds);

var totalElapsed = DateTimeOffset.UtcNow - started;
Log.Verbose("{AddressesHex}HAS Total Executed Time: {Elapsed}", addressesHex, totalElapsed);
Log.Verbose("{AddressesHex} {Source} HAS {Process}: {Elapsed}", addressesHex, source, "Total Executed Time", sw.ElapsedMilliseconds);
return states;
}

Expand Down

0 comments on commit 048bf7a

Please sign in to comment.