Calling 'OnNpcPlayerTarget' took average Xms
pookins
Is this error caused by the "disabled" hooks ?,  any chance of a fix yet ?
(16:07:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1419ms
(16:07:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1414ms
(16:07:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1402ms
(16:07:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1407ms
(16:07:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1421ms
(16:07:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1420ms
(16:08:06) | [FancyDrop] SupplyDrop spawned at (X:1024 Y:1052 Z:-1028)
(16:08:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1417ms
(16:08:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1415ms
(16:08:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1410ms
(16:08:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1449ms
(16:08:43) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took 407ms [GARBAGE COLLECT]
(16:08:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1800ms
(16:08:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1444ms
(16:09:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1433ms
(16:09:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1414ms
(16:09:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1423ms
(16:09:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1426ms
(16:09:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1407ms
(16:09:56) | [FancyDrop] SupplyDrop landed at (X:1024 Y:48 Z:-1028)
(16:09:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1401ms
(16:10:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1403ms
(16:10:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1405ms
(16:10:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1414ms
(16:10:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1449ms
(16:10:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1452ms
(16:10:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1431ms
(16:11:06) | Saved 88,478 ents, cache(0.12), write(0.03), disk(0.01).
(16:11:06) | Saving complete
(16:11:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1447ms
(16:11:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1429ms
(16:11:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1427ms
(16:11:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1423ms
(16:11:39) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took 411ms [GARBAGE COLLECT]
(16:11:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1817ms
(16:11:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1427ms
(16:12:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1426ms
(16:12:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1421ms
(16:12:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1421ms
(16:12:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1415ms
(16:12:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1449ms
(16:12:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1432ms
(16:13:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1432ms
(16:13:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1436ms
(16:13:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1410ms
(16:13:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1417ms
(16:13:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1429ms
(16:13:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1428ms
(16:14:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1432ms
(16:14:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1428ms
(16:14:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1433ms
(16:14:30) | Invalid Position: generic_world[12373123] hq.metal.ore (world) (563.1, -501.5, -1339.8) (destroying)
(16:14:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1430ms
(16:14:43) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took 411ms [GARBAGE COLLECT]
(16:14:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1825ms
(16:14:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1450ms
(16:15:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1442ms
(16:15:17) | Invalid Position: generic_world[12373670] hq.metal.ore (world) (545.1, -501.0, -1294.4) (destroying)
(16:15:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1428ms
(16:15:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1446ms
(16:15:38) | Calling 'CanBeTargeted' on 'BotSpawn v1.8.7' took average 1440ms
(16:15:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1438ms
(16:15:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1428ms
(16:16:05) | Invalid Position: generic_world[12374304] hq.metal.ore (world) (939.3, -504.1, -1526.0) (destroying)
(16:16:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1424ms
(16:16:14) | Invalid Position: generic_world[12374342] hq.metal.ore (world) (982.4, -507.9, -1502.5) (destroying)
(16:16:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1418ms
(16:16:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1430ms
(16:16:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1430ms
(16:16:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1431ms
(16:16:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1448ms
(16:16:59) | Invalid Position: generic_world[12375004] hq.metal.ore (world) (982.8, -507.0, -1142.9) (destroying)
(16:17:07) | Invalid Position: generic_world[12375044] hq.metal.ore (world) (919.3, -500.1, -1437.3) (destroying)
(16:17:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1443ms
(16:17:12) | Invalid Position: generic_world[12375069] hq.metal.ore (world) (956.5, -508.0, -1546.9) (destroying)
(16:17:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1438ms
(16:17:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1445ms
(16:17:29) | Calling 'OnLootSpawn' on 'BetterLoot v3.0.0' took 412ms [GARBAGE COLLECT]
(16:17:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1389ms
(16:17:43) | Invalid Position: generic_world[12375575] hq.metal.ore (world) (567.2, -506.7, -1247.0) (destroying)
(16:17:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1400ms
(16:17:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1417ms
(16:18:02) | Resetting
(16:18:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1397ms
(16:18:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1395ms
(16:18:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1408ms
(16:18:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1397ms
(16:18:42) | Invalid Position: generic_world[12376313] hq.metal.ore (world) (925.8, -500.5, -1156.8) (destroying)
(16:18:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1386ms
(16:18:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1391ms
(16:19:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1427ms
(16:19:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1405ms
(16:19:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1403ms
(16:19:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1420ms
(16:19:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1424ms
(16:19:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1405ms
(16:20:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1384ms
(16:20:18) | Calling 'OnEntityKill' on 'BotSpawn v1.8.7' took average 1383ms
(16:20:27) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took 416ms [GARBAGE COLLECT]
(16:20:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1790ms
(16:20:38) | Calling 'CanBeTargeted' on 'BotSpawn v1.8.7' took average 1384ms
(16:20:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1396ms
(16:20:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1406ms
(16:21:06) | Saved 88,971 ents, cache(0.13), write(0.03), disk(0.01).
(16:21:06) | Saving complete
(16:21:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1396ms
(16:21:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1398ms
(16:21:28) | Calling 'CanBeTargeted' on 'BotSpawn v1.8.7' took average 1418ms
(16:21:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1406ms
(16:21:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1418ms
(16:21:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1433ms
(16:22:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1394ms
(16:22:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1408ms
(16:22:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1407ms
(16:22:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1397ms
(16:22:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1406ms
(16:22:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1397ms
(16:23:05) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took 413ms [GARBAGE COLLECT]
(16:23:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1791ms
(16:23:18) | Calling 'CanBeTargeted' on 'BotSpawn v1.8.7' took average 1410ms
(16:23:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1419ms
(16:23:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1406ms
(16:23:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1415ms
(16:23:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1424ms
(16:24:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1403ms
(16:24:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1406ms
(16:24:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1421ms
(16:24:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1398ms
(16:24:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1411ms
(16:24:58) | Calling 'CanBeTargeted' on 'BotSpawn v1.8.7' took average 1403ms
(16:25:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1402ms
(16:25:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1381ms
(16:25:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1409ms
(16:25:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1402ms
(16:25:48) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1435ms
(16:25:58) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1442ms
(16:26:08) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1416ms
(16:26:18) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1414ms
(16:26:28) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1400ms
(16:26:38) | Calling 'OnNpcPlayerTarget' on 'BotSpawn v1.8.7' took average 1398ms​
Steenamaroo

Hi,
Usually when I see X took > 1000ms it's because something else has shat itself and X is suffering as a result.

Is this an isolated incident?
pookins
Original Poster
In response to Steenamaroo ():
Hi,
Usually when I see X took > 1000ms it's because something else has shat itself and X is...
Sadly no, it is spamming the console all the time roughly between every 3 to 10 seconds, I have unloaded the plugin several times and reloaded it but still the same.
Steenamaroo

Do you know when this started? I'm not seeing other similar reports and haven't experienced it myself.
Have a think about what was changed or added at that time.

I think it's more likely that the calls are taking a long time because something else is bogging the server down,
rather than because the method itself is intensive or whatever.
pookins
Original Poster
In response to Steenamaroo ():
Do you know when this started? I'm not seeing other similar reports and haven't experienced it mysel...
Still the same plugins running for the last few months, only started after the last plugin update, I will see what happens after the next one, The server does not seem to be lagging, and FPS and Ping are not affected (so far) its just annoying in the console. All the bots are spawning in the right areas although I find that they are "bunching up" in some areas like the watertreatment and will have to increase the spawn area after reducing it ,