Dawn of Light

Dawn of Light - Your Portal to DAoC Emulation
http://dolserver.sourceforge.net/

Long callback times and high Hard Drive usage.

http://dolserver.sourceforge.net/viewtopic.php?t=23197

Page 2 of 3

Re: Long callback times and high Hard Drive usage.

PostPosted: Thu Jul 06, 2017 5:14 am
by PlanarChaosRvrtwo
I just removed this message

(leodagan answered so read my guess is waste of time)

Re: Long callback times and high Hard Drive usage.

PostPosted: Thu Jul 06, 2017 5:53 am
by Leodagan
Seriously...

Packet Handler is completely off-topic for this kind of troubles, especially for unhandled packets...

Packet ID 220 is Client To Server 0xDC "Message Filters", DOL don't use these packets (Server doesn't care about Client message filters, he still sends every message and client filters on his side)

The only way to trigger a massive Disk Usage is when the Database is overload, we don't have any piece of code that write to disk for runtime needs !


The RewardMob is not an official DOL core mechanism, by reading the code I suspect that other area of DOL are highly customized in this setup... it will be hard to provide any debug help... but you should look around the Database ! (even trying to log queries when the overload is triggering)

Re: Long callback times and high Hard Drive usage.

PostPosted: Thu Jul 06, 2017 6:29 am
by PlanarChaosRvrtwo
Kay thanks Leodagan tried my best but cant code ^^ So i just had to guess^^

Re: Long callback times and high Hard Drive usage.

PostPosted: Thu Jul 06, 2017 1:06 pm
by psychoninja911
I would expect the RewardMob code too, but then we went to a big camp (Lyonesse Goblins) that do NOT have the RewardMob code, and they gave the same error.

Re: Long callback times and high Hard Drive usage.

PostPosted: Thu Jul 06, 2017 3:42 pm
by Loki
Do you have custom code in your server, and can you confirm you are using the latest revision ?

Re: Long callback times and high Hard Drive usage.

PostPosted: Thu Jul 06, 2017 11:17 pm
by psychoninja911
The RewardMob is custom code right?
And I'm using DOLSharp-1.9.7.3616.

Re: Long callback times and high Hard Drive usage.

PostPosted: Fri Jul 07, 2017 12:00 am
by Loki
RewardMob is custom code, have you considered maybe letting RewardMob drop a token and having a NPC that you can hand the token into then doing the calculations you have in that script?


Or try using else if?

Maybe a long way from what you need, but try and this way we both learn

Re: Long callback times and high Hard Drive usage.

PostPosted: Fri Jul 07, 2017 1:09 pm
by Loki
1.9.7.3617 is the latest release FYI

https://github.com/Dawn-of-Light/DOLSharp

Re: Long callback times and high Hard Drive usage.

PostPosted: Fri Jul 07, 2017 1:19 pm
by psychoninja911
What should I do here?
Line 229-248.
It's missing a bracket somewhere, and the whole thing is getting commented.

Thanks :D

Code: Select all
private static readonly ILog log = LogManager.GetLogger(MethodBase.GetCurrentMethod().DeclaringType);



public override int MaxHealth => base.MaxHealth * 2;

/* public override int MaxSpeedBase
{
get
{
return 191 ;
}
set
{
m_maxSpeedBase = value;
}
}
*/

Re: Long callback times and high Hard Drive usage.

PostPosted: Fri Jul 07, 2017 2:04 pm
by Loki
If you mean removing comment
Code: Select all
public override short MaxSpeedBase
{
get
{
return 191 ;
}
set
{
m_maxSpeedBase = value;
}
}

Or leave as is but either way add a } to bottom of script

Re: Long callback times and high Hard Drive usage.

PostPosted: Fri Jul 07, 2017 2:45 pm
by psychoninja911
Yeah I found the brackets thing at the bottom, I just didn't say anything about it :P

Edit: Line 236 is giving me in error in the server, not allowing the server to load:
Code: Select all
public override int MaxHealth => base.MaxHealth * 2;

Re: Long callback times and high Hard Drive usage.

PostPosted: Fri Jul 07, 2017 3:39 pm
by Loki
Not easy with no VS on this device :(

Try again lol

Re: Long callback times and high Hard Drive usage.

PostPosted: Fri Jul 07, 2017 4:26 pm
by psychoninja911
Okay I'm online. Stand by.
Thanks for your help by the way.

I'm trying to get out of Win/Lin administration and get into programming, hopefully I can help this project for as long as possible. The DOL project that is. I've been playing on DOL servers off/on since 2005? Or so? I always wanted to host, and here I am.

#Edit:
Still occurring. At first I thought it wasn't, or not as much... but it was only a low lvl guy pulling slowly :D
I have 5 or so people online, and you can see it streaming back in.

HOWEVER - it doesn't seem AS bad yet... As far as hard drive usage. It's only spiking up to 50-70% usage.. Before they were maxing it out and crashing the zone.
Code: Select all
2017-07-07 13:49:44,529 - [RegionTime4] - INFO - DOL.GS.GamePlayer - Creamofmushroom saved!
2017-07-07 13:49:44,651 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 515ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0006C4F2 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:49:48,263 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 307ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0006D427 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Protector, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Protector, ID=11158, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:49:48,414 - [21] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=680MB Clients=5 Down=0kb/s (0MB) Up=5kb/s (9MB) In=7pck/s (25K) Out=207pck/s (325K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2970 RegionTime1=34t/s (263) RegionTime2=29t/s (212) RegionTime3=0t/s (1557) RegionTime4=110t/s (842) CPU=17.0% DOL=13.1% pg/s=0.0 dsk/s=9.0
2017-07-07 13:49:48,909 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 325ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0006D69A interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:49:54,142 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 613ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0006E9EB interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:49:54,616 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 320ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0006ECEC interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:49:57,391 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 284ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0006F7E8 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:02,020 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 321ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000709D7 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:03,618 - [RegionTime4] - WARN - DOL.GS.Ability - Parsing ability display name: keyname='Shield' m_serializedNames='1|Shield Ability: Small Shields;2|Shield Ability: Medium Shields;3|Shield Ability: Large Shields', No Value for Level 0
2017-07-07 13:50:03,648 - [RegionTime4] - WARN - DOL.GS.Ability - Parsing ability display name: keyname='Shield' m_serializedNames='1|Shield Ability: Small Shields;2|Shield Ability: Medium Shields;3|Shield Ability: Large Shields', No Value for Level 0
2017-07-07 13:50:03,659 - [RegionTime4] - WARN - DOL.GS.Ability - Parsing ability display name: keyname='Shield' m_serializedNames='1|Shield Ability: Small Shields;2|Shield Ability: Medium Shields;3|Shield Ability: Large Shields', No Value for Level 0
2017-07-07 13:50:05,987 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 308ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x00071964 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:06,387 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 323ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x00071AE5 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:18,429 - [17] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=680MB Clients=5 Down=0kb/s (0MB) Up=4kb/s (10MB) In=7pck/s (25K) Out=145pck/s (329K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2968 RegionTime1=36t/s (260) RegionTime2=29t/s (207) RegionTime3=0t/s (1557) RegionTime4=120t/s (567) CPU=17.3% DOL=12.2% pg/s=0.0 dsk/s=21.3
2017-07-07 13:50:21,140 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 333ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0007547D interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:30,271 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 302ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x00077848 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:34,701 - [23] - INFO - DOL.GS.WeatherManager - Weather Stopped in Region Atlantis (ID 73) CurrentPosition : 668200
[RegionWeather Region=73, Position=229376, Width=78361, Speed=488, Intensity=34, Diffusion=22354, DurationTime=899s, MinPosition=229376, MaxPosition=668185]
2017-07-07 13:50:34,800 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 307ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000789F6 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Protector, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Protector, ID=11158, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:35,726 - [RegionTime4] - INFO - DOL.GS.GamePlayer - Creamofmushroom saved!
2017-07-07 13:50:35,831 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 725ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x00078C5A interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:39,319 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 311ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x00079B99 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:40,575 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 426ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0007A00F interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:42,802 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 561ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0007A83A interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:48,454 - [21] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=681MB Clients=5 Down=0kb/s (0MB) Up=3kb/s (10MB) In=6pck/s (25K) Out=138pck/s (333K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2970 RegionTime1=32t/s (263) RegionTime2=31t/s (209) RegionTime3=11t/s (1557) RegionTime4=61t/s (508) CPU=15.5% DOL=10.1% pg/s=0.0 dsk/s=17.1
2017-07-07 13:50:58,149 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 423ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0007E4B7 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:50:58,516 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 360ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x0007E4B7 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:51:18,479 - [10] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=680MB Clients=5 Down=0kb/s (0MB) Up=2kb/s (10MB) In=6pck/s (25K) Out=98pck/s (336K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2964 RegionTime1=35t/s (264) RegionTime2=29t/s (209) RegionTime3=0t/s (1557) RegionTime4=63t/s (507) CPU=16.2% DOL=9.2% pg/s=0.0 dsk/s=8.8
2017-07-07 13:51:26,802 - [23] - INFO - DOL.GS.WeatherManager - Weather Stopped in Region Ruins of Atlantis (ID 70) CurrentPosition : 652978
[RegionWeather Region=70, Position=524288, Width=63144, Speed=534, Intensity=89, Diffusion=22575, DurationTime=240s, MinPosition=524288, MaxPosition=652968]
2017-07-07 13:51:31,167 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 350ms! DOL.GS.GameLiving+WeaponOnTargetAction tick:0x8000000040000000 interval:0 manager:'RegionTime4' actionSource: (DOL.GS.Scripts.RewardMob name=cliff dweller spearman DB_ID=d1a9e77e-08c2-4b61-972f-b38bc2908d17 oid=-1 state=Deleted reg=200 loc=231443,443896,1570)
2017-07-07 13:51:48,515 - [23] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=681MB Clients=5 Down=0kb/s (0MB) Up=2kb/s (10MB) In=6pck/s (25K) Out=82pck/s (339K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2959 RegionTime1=38t/s (267) RegionTime2=30t/s (211) RegionTime3=1t/s (1557) RegionTime4=58t/s (517) CPU=15.3% DOL=8.7% pg/s=0.0 dsk/s=3.8
2017-07-07 13:51:54,728 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 324ms! DOL.GS.GameLiving+WeaponOnTargetAction tick:0x8000000040000000 interval:0 manager:'RegionTime4' actionSource: (DOL.GS.Scripts.RewardMob name=cliff dweller DB_ID=5157cfa3-ce6a-458e-ac06-ff5600a8c447 oid=-1 state=Deleted reg=200 loc=231449,443885,1569)
2017-07-07 13:51:56,135 - [RegionTime1] - INFO - DOL.GS.GamePlayer - Bonie saved!
2017-07-07 13:52:18,546 - [23] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=679MB Clients=5 Down=0kb/s (0MB) Up=2kb/s (10MB) In=8pck/s (26K) Out=96pck/s (342K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2960 RegionTime1=31t/s (261) RegionTime2=30t/s (213) RegionTime3=0t/s (1557) RegionTime4=82t/s (948) CPU=15.2% DOL=9.7% pg/s=0.0 dsk/s=5.4
2017-07-07 13:52:24,090 - [37] - INFO - DOL.GS.WeatherManager - Weather Started in Region Avalon (ID 51)
[RegionWeather Region=51, Position=229376, Width=74932, Speed=385, Intensity=34, Diffusion=21176, DurationTime=1045s, MinPosition=229376, MaxPosition=631988]
2017-07-07 13:52:38,411 - [17] - INFO - DOL.GS.GameServer - Saving database...
2017-07-07 13:52:38,412 - [17] - DEBUG - DOL.GS.GameServer - Save ThreadId=17
2017-07-07 13:52:38,829 - [17] - INFO - DOL.GS.GamePlayer - Shroomed saved!
2017-07-07 13:52:38,929 - [17] - INFO - DOL.GS.GamePlayer - Relooc saved!
2017-07-07 13:52:39,185 - [17] - INFO - DOL.GS.GamePlayer - Bitsy saved!
2017-07-07 13:52:39,263 - [17] - INFO - DOL.GS.GamePlayer - Creamofmushroom saved!
2017-07-07 13:52:39,352 - [17] - INFO - DOL.GS.GamePlayer - Bonie saved!
2017-07-07 13:52:39,353 - [17] - DEBUG - DOL.GS.GuildMgr - Saving all guilds...
2017-07-07 13:52:39,354 - [17] - DEBUG - DOL.GS.BoatMgr - Saving all boats...
2017-07-07 13:52:39,385 - [17] - INFO - DOL.GS.GameServer - Saving database complete!
2017-07-07 13:52:39,386 - [17] - INFO - DOL.GS.GameServer - Saved all databases and 5 players in 968ms
2017-07-07 13:52:48,571 - [10] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=680MB Clients=5 Down=0kb/s (0MB) Up=1kb/s (10MB) In=6pck/s (26K) Out=45pck/s (343K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2955 RegionTime1=35t/s (267) RegionTime2=29t/s (210) RegionTime3=1t/s (1557) RegionTime4=93t/s (546) CPU=15.3% DOL=8.0% pg/s=0.1 dsk/s=9.5
2017-07-07 13:52:53,813 - [17] - INFO - DOL.GS.WeatherManager - Weather Started in Region Cathal Valley (ID 165)
[RegionWeather Region=165, Position=524288, Width=40878, Speed=502, Intensity=107, Diffusion=19237, DurationTime=211s, MinPosition=524288, MaxPosition=630702]
2017-07-07 13:53:04,326 - [9] - INFO - DOL.GS.GameEvents.ServerListUpdate - Your server's entry was successfully updated!
2017-07-07 13:53:18,600 - [10] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=681MB Clients=5 Down=0kb/s (0MB) Up=1kb/s (10MB) In=5pck/s (26K) Out=51pck/s (344K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2957 RegionTime1=33t/s (261) RegionTime2=29t/s (209) RegionTime3=1t/s (1557) RegionTime4=50t/s (563) CPU=16.0% DOL=6.8% pg/s=1.0 dsk/s=3.3
2017-07-07 13:53:48,640 - [10] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=681MB Clients=5 Down=0kb/s (0MB) Up=2kb/s (10MB) In=8pck/s (26K) Out=75pck/s (347K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2957 RegionTime1=35t/s (272) RegionTime2=29t/s (212) RegionTime3=0t/s (1557) RegionTime4=53t/s (706) CPU=16.0% DOL=7.4% pg/s=0.3 dsk/s=3.5
2017-07-07 13:54:18,664 - [21] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=680MB Clients=5 Down=0kb/s (0MB) Up=2kb/s (10MB) In=9pck/s (27K) Out=73pck/s (349K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2965 RegionTime1=36t/s (264) RegionTime2=29t/s (210) RegionTime3=0t/s (1557) RegionTime4=81t/s (589) CPU=17.4% DOL=7.6% pg/s=11.1 dsk/s=3.9
2017-07-07 13:54:23,232 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 356ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000B0630 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:54:29,546 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 339ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000B1EED interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:54:32,236 - [RegionTime4] - INFO - DOL.GS.GamePlayer - Creamofmushroom saved!
2017-07-07 13:54:32,388 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 533ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000B2946 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:54:35,717 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 332ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000B370D interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:54:40,467 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 584ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000B48A2 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:54:40,802 - [RegionTime4] - WARN - DOL.GS.Ability - Parsing ability display name: keyname='Shield' m_serializedNames='1|Shield Ability: Small Shields;2|Shield Ability: Medium Shields;3|Shield Ability: Large Shields', No Value for Level 0
2017-07-07 13:54:40,819 - [RegionTime4] - WARN - DOL.GS.Ability - Parsing ability display name: keyname='Shield' m_serializedNames='1|Shield Ability: Small Shields;2|Shield Ability: Medium Shields;3|Shield Ability: Large Shields', No Value for Level 0
2017-07-07 13:54:40,828 - [RegionTime4] - WARN - DOL.GS.Ability - Parsing ability display name: keyname='Shield' m_serializedNames='1|Shield Ability: Small Shields;2|Shield Ability: Medium Shields;3|Shield Ability: Large Shields', No Value for Level 0
2017-07-07 13:54:48,678 - [17] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=680MB Clients=5 Down=0kb/s (0MB) Up=3kb/s (10MB) In=10pck/s (27K) Out=125pck/s (353K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2969 RegionTime1=34t/s (264) RegionTime2=29t/s (209) RegionTime3=1t/s (1557) RegionTime4=65t/s (555) CPU=17.2% DOL=10.1% pg/s=0.0 dsk/s=18.6
2017-07-07 13:54:56,255 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 314ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000B874C interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:54:58,717 - [RegionTime4] - WARN - DOL.GS.Ability - Parsing ability display name: keyname='Shield' m_serializedNames='1|Shield Ability: Small Shields;2|Shield Ability: Medium Shields;3|Shield Ability: Large Shields', No Value for Level 0
2017-07-07 13:54:58,736 - [RegionTime4] - WARN - DOL.GS.Ability - Parsing ability display name: keyname='Shield' m_serializedNames='1|Shield Ability: Small Shields;2|Shield Ability: Medium Shields;3|Shield Ability: Large Shields', No Value for Level 0
2017-07-07 13:54:58,758 - [RegionTime4] - WARN - DOL.GS.Ability - Parsing ability display name: keyname='Shield' m_serializedNames='1|Shield Ability: Small Shields;2|Shield Ability: Medium Shields;3|Shield Ability: Large Shields', No Value for Level 0
2017-07-07 13:55:05,277 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 426ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000BAA2E interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:05,567 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 272ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000BABD9 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:08,139 - [21] - INFO - DOL.GS.WeatherManager - Weather Started in Region Molvik (ID 241)
[RegionWeather Region=241, Position=524288, Width=66108, Speed=124, Intensity=107, Diffusion=22523, DurationTime=1061s, MinPosition=524288, MaxPosition=655932]
2017-07-07 13:55:08,898 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 364ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000BB87C interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:09,220 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 317ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000BB87C interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:10,043 - [17] - INFO - DOL.GS.WeatherManager - Weather Stopped in Region Albion Housing (ID 2) CurrentPosition : 648982
[RegionWeather Region=2, Position=393216, Width=59148, Speed=640, Intensity=89, Diffusion=27111, DurationTime=399s, MinPosition=393216, MaxPosition=648972]
2017-07-07 13:55:11,577 - [21] - INFO - DOL.GS.WeatherManager - Weather Started in Region Leirvik (ID 242)
[RegionWeather Region=242, Position=262144, Width=55504, Speed=631, Intensity=103, Diffusion=25149, DurationTime=607s, MinPosition=262144, MaxPosition=645328]
2017-07-07 13:55:18,711 - [21] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=680MB Clients=5 Down=0kb/s (0MB) Up=4kb/s (10MB) In=9pck/s (27K) Out=164pck/s (358K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2968 RegionTime1=38t/s (274) RegionTime2=29t/s (208) RegionTime3=0t/s (1557) RegionTime4=101t/s (533) CPU=16.8% DOL=13.0% pg/s=0.0 dsk/s=12.1
2017-07-07 13:55:23,026 - [21] - INFO - DOL.GS.WeatherManager - Weather Stopped in Region Midgard (ID 100) CurrentPosition : 974359
[RegionWeather Region=100, Position=589824, Width=89606, Speed=525, Intensity=46, Diffusion=28058, DurationTime=732s, MinPosition=589824, MaxPosition=974342]
2017-07-07 13:55:23,378 - [37] - INFO - DOL.GS.WeatherManager - Weather Started in Region Ruinrar Atlantis (ID 71)
[RegionWeather Region=71, Position=524288, Width=57078, Speed=581, Intensity=66, Diffusion=30688, DurationTime=211s, MinPosition=524288, MaxPosition=646902]
2017-07-07 13:55:24,424 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 335ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000BF557 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Protector, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Protector, ID=11158, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:31,641 - [39] - DEBUG - DOL.GS.ScriptMgr - Found spell handler DOL.GS.Spells.PrescienceNodeSpellHandler
2017-07-07 13:55:31,658 - [39] - DEBUG - DOL.GS.ScriptMgr - Found spell handler DOL.GS.Spells.PrescienceSpellHandler
2017-07-07 13:55:34,202 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 312ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000C1BA0 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Protector, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Protector, ID=11158, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:39,544 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 383ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000C3037 interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:42,791 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 300ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000C3D2E interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:43,671 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 411ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000C403B interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:44,015 - [RegionTime4] - INFO - DOL.GS.GamePlayer - Creamofmushroom saved!
2017-07-07 13:55:44,117 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 440ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000C40DF interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Protector, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Protector, ID=11158, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:47,541 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 444ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000C4F2B interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:47,937 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 393ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000C4F2B interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:48,285 - [RegionTime4] - WARN - DOL.GS.GameTimer+TimeManager - callback took 319ms! DOL.GS.Spells.SpellHandler+DelayedCastTimer tick:0x000C504D interval:100 manager:'RegionTime4' spellhandler: (Caster=Forest's Incarnation, IsCasting=True, m_interrupted=False
Spell: Name=Forest's Incarnation, ID=11332, SpellType=DirectDamage
SpellLine: KeyName=Mob Spells, ID=0, Icon=0, Level=1)
2017-07-07 13:55:48,743 - [10] - INFO - DOL.GS.GameEvents.StatPrint - -stats- Mem=680MB Clients=5 Down=0kb/s (0MB) Up=5kb/s (10MB) In=8pck/s (27K) Out=183pck/s (363K) Pool=1022/1023(4) IOCP=1000/1000(4) GH/OH=42/2968 RegionTime1=36t/s (269) RegionTime2=29t/s (209) RegionTime3=1t/s (1557) Region

Re: Long callback times and high Hard Drive usage.

PostPosted: Fri Jul 07, 2017 7:30 pm
by psychoninja911
Nvm... They're back to drawing high usage.\

Image

Ignore that shield thing, I'll fix that soon :P


#Edit: Do you think that the hard drive is just weak or slow?
I don't know what the deal could be... I have 14 people online right now, and it's at ease. HD staying under 20% usage. I can't imagine all 14 people are just sitting afk in town.

#Edit 2: Spoke too soon. Pegged out again:

Image

Re: Long callback times and high Hard Drive usage.

PostPosted: Fri Jul 07, 2017 9:59 pm
by Loki
try this
All times are UTC
Page 2 of 3
Powered by phpBB® Forum Software © phpBB Group
http://www.phpbb.com/