2020-05-06 11:48:49 +02:00
From 0000000000000000000000000000000000000000 Mon Sep 17 00:00:00 2001
2015-01-29 22:25:50 +01:00
From: Aikar <aikar@aikar.co>
2016-03-01 00:09:49 +01:00
Date: Tue, 1 Mar 2016 23:09:29 -0600
2014-10-20 00:58:49 +02:00
Subject: [PATCH] Further improve server tick loop
Improves how the catchup buffer is handled, allowing it to roll both ways
increasing the effeciency of the thread sleep so it only will sleep once.
Also increases the buffer of the catchup to ensure server stays at 20 TPS unless extreme conditions
Previous implementation did not calculate TPS correctly.
Switch to a realistic rolling average and factor in std deviation as an extra reporting variable
diff --git a/src/main/java/net/minecraft/server/MinecraftServer.java b/src/main/java/net/minecraft/server/MinecraftServer.java
2020-06-26 18:20:03 +02:00
index 1fcdbbbc7b60edd1e87bab5f1c5d19a6755de17c..0f2011a776619301dd6a133b9a4044b4f5b69cfc 100644
2014-10-20 00:58:49 +02:00
--- a/src/main/java/net/minecraft/server/MinecraftServer.java
+++ b/src/main/java/net/minecraft/server/MinecraftServer.java
2020-06-25 16:09:55 +02:00
@@ -144,7 +144,7 @@ public abstract class MinecraftServer extends IAsyncTaskHandlerReentrant<TickTas
2014-10-20 00:58:49 +02:00
public org.bukkit.command.ConsoleCommandSender console;
public org.bukkit.command.RemoteConsoleCommandSender remoteConsole;
public ConsoleReader reader;
- public static int currentTick = (int) (System.currentTimeMillis() / 50);
2016-03-01 00:09:49 +01:00
+ public static int currentTick = 0; // Paper - Further improve tick loop
2014-10-20 00:58:49 +02:00
public java.util.Queue<Runnable> processQueue = new java.util.concurrent.ConcurrentLinkedQueue<Runnable>();
public int autosavePeriod;
2020-06-26 18:20:03 +02:00
public CommandDispatcher vanillaCommandDispatcher;
@@ -153,7 +153,7 @@ public abstract class MinecraftServer extends IAsyncTaskHandlerReentrant<TickTas
2017-01-31 05:33:54 +01:00
// Spigot start
2018-08-26 20:11:49 +02:00
public static final int TPS = 20;
public static final int TICK_TIME = 1000000000 / TPS;
2014-10-20 00:58:49 +02:00
- private static final int SAMPLE_INTERVAL = 100;
2018-08-26 20:11:49 +02:00
+ private static final int SAMPLE_INTERVAL = 20; // Paper
public final double[] recentTps = new double[ 3 ];
2017-01-31 05:33:54 +01:00
public final SlackActivityAccountant slackActivityAccountant = new SlackActivityAccountant();
// Spigot end
2020-06-26 18:20:03 +02:00
@@ -807,6 +807,57 @@ public abstract class MinecraftServer extends IAsyncTaskHandlerReentrant<TickTas
2018-08-26 20:11:49 +02:00
{
return ( avg * exp ) + ( tps * ( 1 - exp ) );
}
+
2016-03-01 00:09:49 +01:00
+ // Paper start - Further improve server tick loop
2014-10-20 00:58:49 +02:00
+ private static final long SEC_IN_NANO = 1000000000;
+ private static final long MAX_CATCHUP_BUFFER = TICK_TIME * TPS * 60L;
2018-08-26 20:11:49 +02:00
+ private long lastTick = 0;
+ private long catchupTime = 0;
2014-10-20 00:58:49 +02:00
+ public final RollingAverage tps1 = new RollingAverage(60);
2014-11-28 02:17:45 +01:00
+ public final RollingAverage tps5 = new RollingAverage(60 * 5);
+ public final RollingAverage tps15 = new RollingAverage(60 * 15);
2014-10-20 00:58:49 +02:00
+
+ public static class RollingAverage {
+ private final int size;
+ private long time;
2018-09-18 04:32:37 +02:00
+ private java.math.BigDecimal total;
2014-10-20 00:58:49 +02:00
+ private int index = 0;
2018-09-18 04:32:37 +02:00
+ private final java.math.BigDecimal[] samples;
2014-10-20 00:58:49 +02:00
+ private final long[] times;
+
+ RollingAverage(int size) {
+ this.size = size;
+ this.time = size * SEC_IN_NANO;
2018-09-18 04:32:37 +02:00
+ this.total = dec(TPS).multiply(dec(SEC_IN_NANO)).multiply(dec(size));
+ this.samples = new java.math.BigDecimal[size];
2014-10-20 00:58:49 +02:00
+ this.times = new long[size];
+ for (int i = 0; i < size; i++) {
2018-09-18 04:32:37 +02:00
+ this.samples[i] = dec(TPS);
2014-10-20 00:58:49 +02:00
+ this.times[i] = SEC_IN_NANO;
+ }
+ }
+
2018-09-18 04:32:37 +02:00
+ private static java.math.BigDecimal dec(long t) {
+ return new java.math.BigDecimal(t);
+ }
+ public void add(java.math.BigDecimal x, long t) {
2014-10-20 00:58:49 +02:00
+ time -= times[index];
2018-09-18 04:32:37 +02:00
+ total = total.subtract(samples[index].multiply(dec(times[index])));
2014-10-20 00:58:49 +02:00
+ samples[index] = x;
+ times[index] = t;
+ time += t;
2018-09-18 04:32:37 +02:00
+ total = total.add(x.multiply(dec(t)));
2014-10-20 00:58:49 +02:00
+ if (++index == size) {
+ index = 0;
+ }
+ }
+
+ public double getAverage() {
2018-09-18 04:32:37 +02:00
+ return total.divide(dec(time), 30, java.math.RoundingMode.HALF_UP).doubleValue();
2014-10-20 00:58:49 +02:00
+ }
2018-08-26 20:11:49 +02:00
+ }
2018-09-18 04:32:37 +02:00
+ private static final java.math.BigDecimal TPS_BASE = new java.math.BigDecimal(1E9).multiply(new java.math.BigDecimal(SAMPLE_INTERVAL));
2016-03-01 00:09:49 +01:00
+ // Paper End
2018-08-26 20:11:49 +02:00
// Spigot End
2017-01-31 05:33:54 +01:00
2020-06-25 11:27:25 +02:00
protected void v() {
2020-06-26 18:20:03 +02:00
@@ -819,30 +870,38 @@ public abstract class MinecraftServer extends IAsyncTaskHandlerReentrant<TickTas
2014-10-20 00:58:49 +02:00
// Spigot start
2015-07-26 22:58:37 +02:00
Arrays.fill( recentTps, 20 );
2019-04-24 04:34:11 +02:00
- long curTime, tickSection = SystemUtils.getMonotonicMillis(), tickCount = 1;
2019-05-22 05:58:00 +02:00
+ long start = System.nanoTime(), curTime, tickSection = start; // Paper - Further improve server tick loop
2018-08-26 20:11:49 +02:00
+ lastTick = start - TICK_TIME; // Paper
2014-10-20 00:58:49 +02:00
while (this.isRunning) {
2019-05-22 20:57:27 +02:00
- long i = (curTime = SystemUtils.getMonotonicMillis()) - this.nextTick;
+ long i = ((curTime = System.nanoTime()) / (1000L * 1000L)) - this.nextTick; // Paper
2019-05-22 05:58:00 +02:00
2019-05-22 20:57:27 +02:00
if (i > 5000L && this.nextTick - this.lastOverloadTime >= 30000L) { // CraftBukkit
2019-05-22 05:58:00 +02:00
long j = i / 50L;
if (server.getWarnOnOverload()) // CraftBukkit
2019-04-24 04:34:11 +02:00
- MinecraftServer.LOGGER.warn("Can't keep up! Is the server overloaded? Running {}ms or {} ticks behind", i, j);
2019-05-22 05:58:00 +02:00
+ MinecraftServer.LOGGER.warn("Can't keep up! Is the server overloaded? Running {}ms or {} ticks behind", i, j);
this.nextTick += j * 50L;
this.lastOverloadTime = this.nextTick;
2014-10-20 00:58:49 +02:00
}
2018-08-09 15:02:05 +02:00
- if ( tickCount++ % SAMPLE_INTERVAL == 0 )
2014-11-28 02:17:45 +01:00
+ if ( ++MinecraftServer.currentTick % SAMPLE_INTERVAL == 0 )
2014-10-20 00:58:49 +02:00
{
2019-04-24 04:34:11 +02:00
- double currentTps = 1E3 / ( curTime - tickSection ) * SAMPLE_INTERVAL;
2014-10-20 00:58:49 +02:00
- recentTps[0] = calcTps( recentTps[0], 0.92, currentTps ); // 1/exp(5sec/1min)
- recentTps[1] = calcTps( recentTps[1], 0.9835, currentTps ); // 1/exp(5sec/5min)
- recentTps[2] = calcTps( recentTps[2], 0.9945, currentTps ); // 1/exp(5sec/15min)
+ final long diff = curTime - tickSection;
2018-09-18 04:32:37 +02:00
+ java.math.BigDecimal currentTps = TPS_BASE.divide(new java.math.BigDecimal(diff), 30, java.math.RoundingMode.HALF_UP);
2014-10-20 00:58:49 +02:00
+ tps1.add(currentTps, diff);
+ tps5.add(currentTps, diff);
+ tps15.add(currentTps, diff);
2015-07-26 22:58:37 +02:00
+ // Backwards compat with bad plugins
+ recentTps[0] = tps1.getAverage();
+ recentTps[1] = tps5.getAverage();
+ recentTps[2] = tps15.getAverage();
2016-03-01 00:09:49 +01:00
+ // Paper end
2014-10-20 00:58:49 +02:00
tickSection = curTime;
}
2019-04-24 04:34:11 +02:00
// Spigot end
2018-08-10 16:25:45 +02:00
- MinecraftServer.currentTick = (int) (System.currentTimeMillis() / 50); // CraftBukkit
+ //MinecraftServer.currentTick = (int) (System.currentTimeMillis() / 50); // CraftBukkit // Paper - don't overwrite current tick time
2019-05-07 02:05:41 +02:00
+ lastTick = curTime;
2018-12-17 06:18:06 +01:00
this.nextTick += 50L;
2020-06-25 11:27:25 +02:00
GameProfilerTick gameprofilertick = GameProfilerTick.a("Server");
2014-10-20 00:58:49 +02:00
diff --git a/src/main/java/org/bukkit/craftbukkit/CraftServer.java b/src/main/java/org/bukkit/craftbukkit/CraftServer.java
2020-06-27 07:12:11 +02:00
index 3e2328079f5f98f3f10cc1badd1059a3703eb2d7..0f5af8365abe99971a815285703a3b598f130a0d 100644
2014-10-20 00:58:49 +02:00
--- a/src/main/java/org/bukkit/craftbukkit/CraftServer.java
+++ b/src/main/java/org/bukkit/craftbukkit/CraftServer.java
2020-06-27 07:12:11 +02:00
@@ -2045,6 +2045,17 @@ public final class CraftServer implements Server {
2016-03-01 00:09:49 +01:00
return CraftMagicNumbers.INSTANCE;
}
+ // Paper - Add getTPS API - Further improve tick loop
+ @Override
+ public double[] getTPS() {
+ return new double[] {
2019-05-06 05:53:47 +02:00
+ net.minecraft.server.MinecraftServer.getServer().tps1.getAverage(),
+ net.minecraft.server.MinecraftServer.getServer().tps5.getAverage(),
+ net.minecraft.server.MinecraftServer.getServer().tps15.getAverage()
2016-03-01 00:09:49 +01:00
+ };
+ }
+ // Paper end
+
2014-11-28 02:17:45 +01:00
private final Spigot spigot = new Spigot()
{
2014-10-20 00:58:49 +02:00
diff --git a/src/main/java/org/spigotmc/TicksPerSecondCommand.java b/src/main/java/org/spigotmc/TicksPerSecondCommand.java
2020-05-06 11:48:49 +02:00
index be2e31deae605fbf5a3d8bfc235161804f7bdb43..387af9d5c01701eafdb416204e5e2f94116d366f 100644
2014-10-20 00:58:49 +02:00
--- a/src/main/java/org/spigotmc/TicksPerSecondCommand.java
+++ b/src/main/java/org/spigotmc/TicksPerSecondCommand.java
2014-11-28 02:17:45 +01:00
@@ -1,8 +1,5 @@
2014-10-20 00:58:49 +02:00
package org.spigotmc;
-import com.google.common.base.Joiner;
-import net.minecraft.server.MinecraftServer;
2014-11-28 02:17:45 +01:00
-import com.google.common.collect.Iterables;
2014-10-20 00:58:49 +02:00
import org.bukkit.ChatColor;
import org.bukkit.command.Command;
import org.bukkit.command.CommandSender;
Improve mid tick chunk loading, Fix Oversleep, other improvements
Process loads outside of any canSleep check. Original intent was to
only apply those restrictions to generations but realized I had some
checks higher up the call chain.
Reworked the back off strategy to just run every 1 millisecond per world,
and to apply the per tick limit to generations only.
This guarantees that your chunk will load with at most around 1ms delay.
Additionally, fire midTick processing in a few more places, notably the
oversleep section so we can keep processing loads here too which has
a large up to 50ms window...
Speaking of oversleep, we had a bug in our implementation changes for
Timings that caused oversleep to not sleep the correct amount.
Because we now moved it into the NEXT tick instead of THIS tick, the
value of nextTick had already been increased to +50ms, resulting in
the risk of sleeping more than it should, but, more importantly, this
caused every task that was trying to NOT run during oversleep to actually
run during oversleep.
This is now fixed.
Another small tweak is to the /tps command, to no longer show the star when
TPS is right at 20.
Due to ineffeciencies in the sleep precision, TPS is commonly 20.02.
This causes the star to show up almost constantly, so now only show it if
we actually hit a real "catchup".
This commit also improves the changes to the CallbackExecutor, in that
it now is also recursion safe.
It was possible that the executor could run tasks out of desired order
if the executor task scheduled more executor tasks.
We solve this by ensuring new additions do not enter the currently iterated queue.
Each depth level will have its own queue.
Fixes #3220
2020-04-26 05:47:29 +02:00
@@ -26,20 +23,22 @@ public class TicksPerSecondCommand extends Command
2014-10-20 00:58:49 +02:00
return true;
}
- StringBuilder sb = new StringBuilder( ChatColor.GOLD + "TPS from last 1m, 5m, 15m: " );
- for ( double tps : MinecraftServer.getServer().recentTps )
- {
- sb.append( format( tps ) );
- sb.append( ", " );
2016-03-01 00:09:49 +01:00
+ // Paper start - Further improve tick handling
+ double[] tps = org.bukkit.Bukkit.getTPS();
2014-10-20 00:58:49 +02:00
+ String[] tpsAvg = new String[tps.length];
+
2016-03-01 00:09:49 +01:00
+ for ( int i = 0; i < tps.length; i++) {
+ tpsAvg[i] = format( tps[i] );
2014-10-20 00:58:49 +02:00
}
- sender.sendMessage( sb.substring( 0, sb.length() - 2 ) );
2014-11-28 02:17:45 +01:00
+ sender.sendMessage( ChatColor.GOLD + "TPS from last 1m, 5m, 15m: " + org.apache.commons.lang.StringUtils.join(tpsAvg, ", "));
2016-03-01 00:09:49 +01:00
+ // Paper end
2014-10-20 00:58:49 +02:00
return true;
}
- private String format(double tps)
2016-03-01 00:09:49 +01:00
+ private static String format(double tps) // Paper - Made static
2014-10-20 00:58:49 +02:00
{
return ( ( tps > 18.0 ) ? ChatColor.GREEN : ( tps > 16.0 ) ? ChatColor.YELLOW : ChatColor.RED ).toString()
Improve mid tick chunk loading, Fix Oversleep, other improvements
Process loads outside of any canSleep check. Original intent was to
only apply those restrictions to generations but realized I had some
checks higher up the call chain.
Reworked the back off strategy to just run every 1 millisecond per world,
and to apply the per tick limit to generations only.
This guarantees that your chunk will load with at most around 1ms delay.
Additionally, fire midTick processing in a few more places, notably the
oversleep section so we can keep processing loads here too which has
a large up to 50ms window...
Speaking of oversleep, we had a bug in our implementation changes for
Timings that caused oversleep to not sleep the correct amount.
Because we now moved it into the NEXT tick instead of THIS tick, the
value of nextTick had already been increased to +50ms, resulting in
the risk of sleeping more than it should, but, more importantly, this
caused every task that was trying to NOT run during oversleep to actually
run during oversleep.
This is now fixed.
Another small tweak is to the /tps command, to no longer show the star when
TPS is right at 20.
Due to ineffeciencies in the sleep precision, TPS is commonly 20.02.
This causes the star to show up almost constantly, so now only show it if
we actually hit a real "catchup".
This commit also improves the changes to the CallbackExecutor, in that
it now is also recursion safe.
It was possible that the executor could run tasks out of desired order
if the executor task scheduled more executor tasks.
We solve this by ensuring new additions do not enter the currently iterated queue.
Each depth level will have its own queue.
Fixes #3220
2020-04-26 05:47:29 +02:00
- + ( ( tps > 20.0 ) ? "*" : "" ) + Math.min( Math.round( tps * 100.0 ) / 100.0, 20.0 );
+ + ( ( tps > 21.0 ) ? "*" : "" ) + Math.min( Math.round( tps * 100.0 ) / 100.0, 20.0 ); // Paper - only print * at 21, we commonly peak to 20.02 as the tick sleep is not accurate enough, stop the noise
}
}