[20:54:00] [ServerMain/INFO]: Environment: authHost='https://authserver.mojang.com', accountsHost='https://api.mojang.com', sessionHost='https://sessionserver.mojang.com', servicesHost='https://api.minecraftservices.com', name='PROD' [20:54:02] [ServerMain/INFO]: Loaded 7 recipes [20:54:02] [ServerMain/INFO]: Loaded 1260 advancements [20:54:03] [Server thread/INFO]: Starting minecraft server version 23w14a [20:54:03] [Server thread/INFO]: Loading properties [20:54:03] [Server thread/INFO]: Default game type: SURVIVAL [20:54:03] [Server thread/INFO]: Generating keypair [20:54:03] [Server console handler/ERROR]: Exception handling console input java.io.IOException: The handle is invalid at java.io.FileInputStream.readBytes(Native Method) ~[?:?] at java.io.FileInputStream.read(FileInputStream.java:276) ~[?:?] at java.io.BufferedInputStream.read1(BufferedInputStream.java:282) ~[?:?] at java.io.BufferedInputStream.read(BufferedInputStream.java:343) ~[?:?] at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:270) ~[?:?] at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:313) ~[?:?] at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:188) ~[?:?] at java.io.InputStreamReader.read(InputStreamReader.java:177) ~[?:?] at java.io.BufferedReader.fill(BufferedReader.java:162) ~[?:?] at java.io.BufferedReader.readLine(BufferedReader.java:329) ~[?:?] at java.io.BufferedReader.readLine(BufferedReader.java:396) ~[?:?] at ahc$1.run(SourceFile:89) ~[server-23w14a.jar:?] [20:54:03] [Server thread/INFO]: Starting Minecraft server on *:25565 [20:54:04] [Server thread/INFO]: Using default channel type [20:54:04] [Server thread/INFO]: Preparing level "world" [20:54:06] [Server thread/INFO]: Preparing start region for dimension minecraft:overworld [20:54:10] [Worker-Main-15/INFO]: Preparing spawn area: 0% [20:54:10] [Worker-Main-15/INFO]: Preparing spawn area: 0% [20:54:10] [Worker-Main-15/INFO]: Preparing spawn area: 0% [20:54:10] [Worker-Main-15/INFO]: Preparing spawn area: 0% [20:54:10] [Worker-Main-11/INFO]: Preparing spawn area: 0% [20:54:10] [Worker-Main-11/INFO]: Preparing spawn area: 0% [20:54:10] [Worker-Main-11/INFO]: Preparing spawn area: 0% [20:54:10] [Worker-Main-11/INFO]: Preparing spawn area: 0% [20:54:10] [Worker-Main-11/INFO]: Preparing spawn area: 0% [20:54:10] [Worker-Main-11/INFO]: Preparing spawn area: 0% [20:54:11] [Worker-Main-2/INFO]: Preparing spawn area: 17% [20:54:11] [Worker-Main-14/INFO]: Preparing spawn area: 46% [20:54:12] [Server thread/INFO]: Time elapsed: 6005 ms [20:54:12] [Server thread/INFO]: Done (7.779s)! For help, type "help" [20:54:44] [User Authenticator #1/INFO]: UUID of player _Rhythmic is f899e56c-f741-4a92-a3d8-ee6f9ef05546 [20:54:44] [Server thread/INFO]: _Rhythmic[/127.0.0.1:57032] logged in with entity id 97 at (892.36721630175, 64.0, -3624.11840266026) [20:54:44] [Server thread/INFO]: _Rhythmic joined the game [20:55:08] [Server thread/INFO]: [_Rhythmic: Set the time to 6000] [20:55:12] [Server thread/INFO]: [_Rhythmic: Gamerule doDaylightCycle is now set to: false] [20:55:19] [Server thread/INFO]: [_Rhythmic: Gamerule doWeatherCycle is now set to: false] [20:55:25] [Server thread/INFO]: [_Rhythmic: Gamerule doTraderSpawning is now set to: false] [20:58:44] [Server thread/INFO]: Started flight recorder profiling id(1):name(server-23w14a-2023-04-05-205843) - will dump to debug\server-2023-04-05-205843.jfr on exit or stop command [20:59:53] [Server thread/WARN]: Can't keep up! Is the server overloaded? Running 13720ms or 274 ticks behind [21:01:36] [Server thread/INFO]: Locating element minecraft:shipwreck took 0 ms [21:01:40] [Server thread/INFO]: [_Rhythmic: Teleported _Rhythmic to 528.500000, 64.000000, -3631.500000] [21:01:40] [Server thread/WARN]: _Rhythmic moved too quickly! -179.05923931892278,0.0,21.167620781893675 [21:02:21] [Server thread/INFO]: Dumped flight recorder profiling to debug\server-2023-04-05-205843.jfr [21:02:22] [Server thread/INFO]: { "startedEpoch": 1680753524113, "endedEpoch": 1680753741725, "durationMs": 217611, "heap": { "allocationRateBytesPerSecond": 5.804062340740741E7, "gcCount": 32, "gcOverHeadPercent": 0.017278539, "gcTotalDurationMs": 3760 }, "cpuPercent": { "jvm": { "min": 0.0, "average": 0.0013662529900617334, "max": 0.04084440693259239 }, "userJvm": { "min": 7.624087738804519E-4, "average": 0.01620105100094938, "max": 0.3747863173484802 }, "system": { "min": 0.0030601778998970985, "average": 0.02960837946629222, "max": 0.46301013231277466 } }, "network": { "sent": { "totalBytes": 17248802, "count": 156920, "bytesPerSecond": 79487.5668202765, "countPerSecond": 723.1336405529954, "topContributors": [ { "protocolId": 0, "packetId": 36, "packetName": "wc", "totalBytes": 15142433, "count": 482 }, { "protocolId": 0, "packetId": 39, "packetName": "wf", "totalBytes": 760492, "count": 284 }, { "protocolId": 0, "packetId": 84, "packetName": "xx", "totalBytes": 317696, "count": 39803 }, { "protocolId": 0, "packetId": 43, "packetName": "a", "totalBytes": 306462, "count": 34098 }, { "protocolId": 0, "packetId": 44, "packetName": "b", "totalBytes": 273848, "count": 24925 }, { "protocolId": 0, "packetId": 104, "packetName": "yr", "totalBytes": 126917, "count": 4381 }, { "protocolId": 0, "packetId": 66, "packetName": "xf", "totalBytes": 113211, "count": 37927 }, { "protocolId": 0, "packetId": 67, "packetName": "xg", "totalBytes": 40648, "count": 897 }, { "protocolId": 0, "packetId": 82, "packetName": "xv", "totalBytes": 37937, "count": 4959 }, { "protocolId": 0, "packetId": 1, "packetName": "ur", "totalBytes": 29517, "count": 557 } ] }, "received": { "totalBytes": 44704, "count": 1943, "bytesPerSecond": 206.00921658986175, "countPerSecond": 8.953917050691244, "topContributors": [ { "protocolId": 0, "packetId": 21, "packetName": "b", "totalBytes": 20264, "count": 596 }, { "protocolId": 0, "packetId": 20, "packetName": "a", "totalBytes": 18148, "count": 698 }, { "protocolId": 0, "packetId": 11, "packetName": "zn", "totalBytes": 2006, "count": 84 }, { "protocolId": 0, "packetId": 22, "packetName": "c", "totalBytes": 1540, "count": 154 }, { "protocolId": 0, "packetId": 43, "packetName": "aaq", "totalBytes": 896, "count": 152 }, { "protocolId": 0, "packetId": 29, "packetName": "aac", "totalBytes": 644, "count": 53 }, { "protocolId": 0, "packetId": 16, "packetName": "zs", "totalBytes": 288, "count": 24 }, { "protocolId": 0, "packetId": 49, "packetName": "aaw", "totalBytes": 260, "count": 10 }, { "protocolId": 0, "packetId": 38, "packetName": "aal", "totalBytes": 132, "count": 66 }, { "protocolId": 0, "packetId": 4, "packetName": "zg", "totalBytes": 130, "count": 3 } ] } }, "fileIO": { "write": { "totalBytes": 22831662, "count": 3614, "bytesPerSecond": 105215.03225806452, "countPerSecond": 16.65437788018433, "topContributors": [ { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.0.-8.mca", "totalBytes": 6789767 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.1.-8.mca", "totalBytes": 5985240 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.0.-7.mca", "totalBytes": 4791550 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.1.-7.mca", "totalBytes": 1554525 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.1.-8.mca", "totalBytes": 1346644 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.2.-8.mca", "totalBytes": 803783 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.2.-7.mca", "totalBytes": 450856 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.1.-7.mca", "totalBytes": 323216 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.0.0.mca", "totalBytes": 176694 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.-1.0.mca", "totalBytes": 146651 } ] }, "read": { "totalBytes": 1168559, "count": 780, "bytesPerSecond": 5385.064516129032, "countPerSecond": 3.5944700460829493, "topContributors": [ { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.1.-8.mca", "totalBytes": 352256 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.1.-7.mca", "totalBytes": 245760 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\versions\\23w14a\\server-23w14a.jar", "totalBytes": 207353 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.0.-8.mca", "totalBytes": 90112 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.0.-7.mca", "totalBytes": 90112 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.1.-8.mca", "totalBytes": 49152 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\libraries\\it\\unimi\\dsi\\fastutil\\8.5.9\\fastutil-8.5.9.jar", "totalBytes": 17717 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.1.-7.mca", "totalBytes": 16384 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.-2.-12.mca", "totalBytes": 16384 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.2.-8.mca", "totalBytes": 12288 } ] } }, "serverTick": { "minMs": 7.339126, "averageMs": 11.938879768867926, "maxMs": 67.668376, "p99": 42.60647812, "p90": 18.208035199999998, "p75": 11.032794500000001, "p50": 9.789193000000001 }, "threadAllocation": [ { "thread": "AWT-EventQueue-0", "bytesPerSecond": 57574.86255924171 }, { "thread": "AWT-Shutdown", "bytesPerSecond": 0.0 }, { "thread": "AWT-Windows", "bytesPerSecond": 0.0 }, { "thread": "Attach Listener", "bytesPerSecond": 0.0 }, { "thread": "C1 CompilerThread0", "bytesPerSecond": 2.8056872037914693 }, { "thread": "C1 CompilerThread1", "bytesPerSecond": 0.0 }, { "thread": "C1 CompilerThread2", "bytesPerSecond": -2.3351351351351353 }, { "thread": "C1 CompilerThread3", "bytesPerSecond": -1.6864864864864866 }, { "thread": "C2 CompilerThread0", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread1", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread2", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread3", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread4", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread5", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread6", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread7", "bytesPerSecond": 0.0 }, { "thread": "Common-Cleaner", "bytesPerSecond": 0.0 }, { "thread": "DestroyJavaVM", "bytesPerSecond": 0.0 }, { "thread": "Finalizer", "bytesPerSecond": 0.0 }, { "thread": "IO-Worker-21", "bytesPerSecond": 79261.23222748814 }, { "thread": "IO-Worker-24", "bytesPerSecond": 94318.18009478673 }, { "thread": "IO-Worker-25", "bytesPerSecond": 83981.66486486487 }, { "thread": "IO-Worker-26", "bytesPerSecond": 298757.9428571428 }, { "thread": "JFR Periodic Tasks", "bytesPerSecond": 146.3127962085308 }, { "thread": "JFR Recorder Thread", "bytesPerSecond": 0.0 }, { "thread": "JNA Cleaner", "bytesPerSecond": 0.0 }, { "thread": "Java2D Disposer", "bytesPerSecond": 0.0 }, { "thread": "Monitor Deflation Thread", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #0", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #1", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #2", "bytesPerSecond": 453473.4028436019 }, { "thread": "Notification Thread", "bytesPerSecond": 0.0 }, { "thread": "Reference Handler", "bytesPerSecond": 0.0 }, { "thread": "Server Watchdog", "bytesPerSecond": 0.0 }, { "thread": "Server thread", "bytesPerSecond": 3.762411177251185E7 }, { "thread": "Service Thread", "bytesPerSecond": 0.0 }, { "thread": "Signal Dispatcher", "bytesPerSecond": 0.0 }, { "thread": "Sweeper thread", "bytesPerSecond": 0.0 }, { "thread": "Thread-1", "bytesPerSecond": 5.156398104265403 }, { "thread": "Timer hack thread", "bytesPerSecond": 0.0 }, { "thread": "TimerQueue", "bytesPerSecond": 526.4454976303317 }, { "thread": "Worker-Main-1", "bytesPerSecond": 1200018.9194312796 }, { "thread": "Worker-Main-10", "bytesPerSecond": 990335.3933649289 }, { "thread": "Worker-Main-11", "bytesPerSecond": 964279.8483412323 }, { "thread": "Worker-Main-12", "bytesPerSecond": 1454328.0 }, { "thread": "Worker-Main-13", "bytesPerSecond": 1357545.9336492892 }, { "thread": "Worker-Main-14", "bytesPerSecond": 1301673.7819905214 }, { "thread": "Worker-Main-15", "bytesPerSecond": 1077819.4123222749 }, { "thread": "Worker-Main-16", "bytesPerSecond": 921079.5829383886 }, { "thread": "Worker-Main-17", "bytesPerSecond": 986375.3933649289 }, { "thread": "Worker-Main-18", "bytesPerSecond": 1045089.4786729858 }, { "thread": "Worker-Main-19", "bytesPerSecond": 1110602.7298578199 }, { "thread": "Worker-Main-2", "bytesPerSecond": 1244959.355450237 }, { "thread": "Worker-Main-3", "bytesPerSecond": 1428001.1753554503 }, { "thread": "Worker-Main-4", "bytesPerSecond": 1043431.7345971564 }, { "thread": "Worker-Main-5", "bytesPerSecond": 1491108.625592417 }, { "thread": "Worker-Main-6", "bytesPerSecond": 1183127.7725118482 }, { "thread": "Worker-Main-7", "bytesPerSecond": 1542944.037914692 }, { "thread": "Worker-Main-8", "bytesPerSecond": 1391261.6872037915 }, { "thread": "Worker-Main-9", "bytesPerSecond": 1291508.2464454977 } ], "chunkGen": { "durationNanosTotal": 9.20573278E10, "status": [ { "state": "noise", "count": 351, "durationNanosTotal": 49489316600, "durationNanosAvg": 140995203, "durationNanosPercentiles": { "p99": 1.1944177E9, "p90": 2.331915E8, "p75": 1.213198E8, "p50": 7.41091E7 }, "fastest": { "durationNanos": 30793400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 22, "chunkPosZ": 22, "worldPosX": 352, "worldPosZ": -3888 }, "slowest": { "durationNanos": 1228004300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 29, "chunkPosZ": 29, "worldPosX": 464, "worldPosZ": -3568 }, "secondSlowest": { "durationNanos": 1206873600, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 29, "chunkPosZ": 29, "worldPosX": 464, "worldPosZ": -3712 } }, { "state": "light", "count": 307, "durationNanosTotal": 15815810900, "durationNanosAvg": 51517299, "durationNanosPercentiles": { "p99": 1.42191336E8, "p90": 9.362412E7, "p75": 6.81463E7, "p50": 4.25701E7 }, "fastest": { "durationNanos": 11120700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 24, "chunkPosZ": 24, "worldPosX": 384, "worldPosZ": -3696 }, "slowest": { "durationNanos": 167067000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 28, "chunkPosZ": 28, "worldPosX": 448, "worldPosZ": -3440 }, "secondSlowest": { "durationNanos": 167054900, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 29, "chunkPosZ": 29, "worldPosX": 464, "worldPosZ": -3440 } }, { "state": "features", "count": 329, "durationNanosTotal": 11369277800, "durationNanosAvg": 34557075, "durationNanosPercentiles": { "p99": 2.35932216E8, "p90": 7.362288E7, "p75": 4.29296E7, "p50": 2.10129E7 }, "fastest": { "durationNanos": 3547800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 23, "chunkPosZ": 23, "worldPosX": 368, "worldPosZ": -3664 }, "slowest": { "durationNanos": 405935200, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 30, "chunkPosZ": 30, "worldPosX": 480, "worldPosZ": -3632 }, "secondSlowest": { "durationNanos": 339703900, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 30, "chunkPosZ": 30, "worldPosX": 480, "worldPosZ": -3616 } }, { "state": "surface", "count": 351, "durationNanosTotal": 5889009500, "durationNanosAvg": 16777804, "durationNanosPercentiles": { "p99": 3.715285E7, "p90": 2.0146E7, "p75": 1.78537E7, "p50": 1.51666E7 }, "fastest": { "durationNanos": 6991800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 25, "chunkPosZ": 25, "worldPosX": 400, "worldPosZ": -3856 }, "slowest": { "durationNanos": 266499700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 29, "chunkPosZ": 29, "worldPosX": 464, "worldPosZ": -3648 }, "secondSlowest": { "durationNanos": 110836400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 29, "chunkPosZ": 29, "worldPosX": 464, "worldPosZ": -3616 } }, { "state": "full", "count": 317, "durationNanosTotal": 4249355600, "durationNanosAvg": 13404907, "durationNanosPercentiles": { "p99": 1.0454348E8, "p90": 3.7004E7, "p75": 1.80709E7, "p50": 7351300.0 }, "fastest": { "durationNanos": 36300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 28, "chunkPosZ": 28, "worldPosX": 448, "worldPosZ": -3824 }, "slowest": { "durationNanos": 117705800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 22, "chunkPosZ": 22, "worldPosX": 352, "worldPosZ": -3840 }, "secondSlowest": { "durationNanos": 114751700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 22, "chunkPosZ": 22, "worldPosX": 352, "worldPosZ": -3824 } }, { "state": "biomes", "count": 373, "durationNanosTotal": 3524620700, "durationNanosAvg": 9449385, "durationNanosPercentiles": { "p99": 2.1188E7, "p90": 1.262292E7, "p75": 9720600.0, "p50": 8331400.0 }, "fastest": { "durationNanos": 3963400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 20, "chunkPosZ": 20, "worldPosX": 320, "worldPosZ": -3760 }, "slowest": { "durationNanos": 151603400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 27, "chunkPosZ": 27, "worldPosX": 432, "worldPosZ": -3552 }, "secondSlowest": { "durationNanos": 22514000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 26, "chunkPosZ": 26, "worldPosX": 416, "worldPosZ": -3504 } }, { "state": "carvers", "count": 351, "durationNanosTotal": 837456700, "durationNanosAvg": 2385916, "durationNanosPercentiles": { "p99": 7271200.0, "p90": 4330400.0, "p75": 3086900.0, "p50": 1889100.0 }, "fastest": { "durationNanos": 362400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 24, "chunkPosZ": 24, "worldPosX": 384, "worldPosZ": -3888 }, "slowest": { "durationNanos": 16227300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 24, "chunkPosZ": 24, "worldPosX": 384, "worldPosZ": -3584 }, "secondSlowest": { "durationNanos": 12396000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 29, "chunkPosZ": 29, "worldPosX": 464, "worldPosZ": -3648 } }, { "state": "structure_starts", "count": 623, "durationNanosTotal": 777574100, "durationNanosAvg": 1248112, "durationNanosPercentiles": { "p99": 3.429946E7, "p90": 98520.0, "p75": 41650.0, "p50": 19400.0 }, "fastest": { "durationNanos": 100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 23, "chunkPosZ": 23, "worldPosX": 368, "worldPosZ": -3264 }, "slowest": { "durationNanos": 178093800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": -207, "chunkPosZ": -207, "worldPosX": -3312, "worldPosZ": -4800 }, "secondSlowest": { "durationNanos": 117470800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 10, "chunkPosZ": 10, "worldPosX": 160, "worldPosZ": -3664 } }, { "state": "structure_references", "count": 373, "durationNanosTotal": 69112000, "durationNanosAvg": 185286, "durationNanosPercentiles": { "p99": 1448236.0, "p90": 339640.0, "p75": 177500.0, "p50": 88000.0 }, "fastest": { "durationNanos": 9500, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 20, "chunkPosZ": 20, "worldPosX": 320, "worldPosZ": -3808 }, "slowest": { "durationNanos": 9233100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 27, "chunkPosZ": 27, "worldPosX": 432, "worldPosZ": -3600 }, "secondSlowest": { "durationNanos": 2528300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 27, "chunkPosZ": 27, "worldPosX": 432, "worldPosZ": -3712 } }, { "state": "spawn", "count": 307, "durationNanosTotal": 32371600, "durationNanosAvg": 105444, "durationNanosPercentiles": { "p99": 334806.0, "p90": 190820.0, "p75": 135350.0, "p50": 84700.0 }, "fastest": { "durationNanos": 6000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 24, "chunkPosZ": 24, "worldPosX": 384, "worldPosZ": -3632 }, "slowest": { "durationNanos": 1445900, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 25, "chunkPosZ": 25, "worldPosX": 400, "worldPosZ": -3824 }, "secondSlowest": { "durationNanos": 525300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 23, "chunkPosZ": 23, "worldPosX": 368, "worldPosZ": -3680 } }, { "state": "liquid_carvers", "count": 351, "durationNanosTotal": 2280800, "durationNanosAvg": 6498, "durationNanosPercentiles": { "p99": 52550.0, "p90": 12500.0, "p75": 6300.0, "p50": 3900.0 }, "fastest": { "durationNanos": 200, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 20, "chunkPosZ": 20, "worldPosX": 320, "worldPosZ": -3552 }, "slowest": { "durationNanos": 146800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 29, "chunkPosZ": 29, "worldPosX": 464, "worldPosZ": -3568 }, "secondSlowest": { "durationNanos": 100300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 29, "chunkPosZ": 29, "worldPosX": 464, "worldPosZ": -3392 } }, { "state": "heightmaps", "count": 307, "durationNanosTotal": 1141500, "durationNanosAvg": 3718, "durationNanosPercentiles": { "p99": 21764.0, "p90": 5980.0, "p75": 3850.0, "p50": 2300.0 }, "fastest": { "durationNanos": 100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 24, "chunkPosZ": 24, "worldPosX": 384, "worldPosZ": -3760 }, "slowest": { "durationNanos": 156100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 21, "chunkPosZ": 21, "worldPosX": 336, "worldPosZ": -3424 }, "secondSlowest": { "durationNanos": 44000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 29, "chunkPosZ": 29, "worldPosX": 464, "worldPosZ": -3664 } } ] } } [21:02:22] [Server thread/INFO]: Dumped recording summary to debug\jfr-report-server-2023-04-05-205843.json [21:02:33] [Server thread/INFO]: Started flight recorder profiling id(2):name(server-23w14a-2023-04-05-210232) - will dump to debug\server-2023-04-05-210232.jfr on exit or stop command [21:02:43] [Server thread/INFO]: [_Rhythmic: Applied effect Night Vision to _Rhythmic] [21:03:00] [Server thread/INFO]: [_Rhythmic: Applied effect Conduit Power to _Rhythmic] [21:04:18] [Server thread/INFO]: [_Rhythmic: Set own game mode to Spectator Mode] [21:04:55] [Server thread/INFO]: Locating element minecraft:deep_ocean took 505 ms [21:05:02] [Server thread/INFO]: [_Rhythmic: Teleported _Rhythmic to 1489.500000, 96.000000, -2170.500000] [21:05:03] [Server thread/WARN]: _Rhythmic moved too quickly! 576.1797979184784,-0.9384523784509327,959.917910457863 [21:05:30] [Server thread/INFO]: [_Rhythmic: Set own game mode to Creative Mode] [21:05:50] [Server thread/INFO]: [_Rhythmic: Set own game mode to Spectator Mode] [21:06:10] [Server thread/WARN]: _Rhythmic moved too quickly! 2.822436646295955,0.0,10.433315261257349 [21:06:33] [Server thread/INFO]: [_Rhythmic: Set own game mode to Creative Mode] [21:08:50] [Server thread/INFO]: [_Rhythmic: Generated structure "minecraft:shipwreck" at 2715, 65, -1202] [21:09:22] [Server thread/INFO]: [_Rhythmic: Generated structure "minecraft:shipwreck" at 2703, 72, -1213] [21:09:50] [Server thread/INFO]: [_Rhythmic: Generated structure "minecraft:shipwreck" at 2679, 78, -1278] [21:10:15] [Server thread/INFO]: [_Rhythmic: Teleported _Rhythmic to 3954.718271, 78.618135, 663.833841] [21:10:15] [Server thread/WARN]: _Rhythmic moved too quickly! 1300.0,0.0,1928.0 [21:10:15] [Server thread/WARN]: _Rhythmic moved too quickly! 1300.0,0.0,1928.0 [21:10:31] [Server thread/INFO]: [_Rhythmic: Generated structure "minecraft:shipwreck" at 3966, 87, 685] [21:10:45] [Server thread/INFO]: [_Rhythmic: Generated structure "minecraft:shipwreck" at 3959, 87, 700] [21:11:20] [Server thread/WARN]: Can't keep up! Is the server overloaded? Running 27604ms or 552 ticks behind [21:11:20] [Server thread/INFO]: <_Rhythmic> lol [21:11:59] [Server thread/INFO]: Dumped flight recorder profiling to debug\server-2023-04-05-210232.jfr [21:12:00] [Server thread/INFO]: { "startedEpoch": 1680753524243, "endedEpoch": 1680754319695, "durationMs": 795451, "heap": { "allocationRateBytesPerSecond": 2.6550833568904594E8, "gcCount": 258, "gcOverHeadPercent": 0.01955746, "gcTotalDurationMs": 15557 }, "cpuPercent": { "jvm": { "min": 0.0, "average": 0.0011535122292433205, "max": 0.008360438048839569 }, "userJvm": { "min": 0.0, "average": 0.023988117978036804, "max": 0.13942287862300873 }, "system": { "min": 0.0015254614409059286, "average": 0.04637495300858476, "max": 0.2754662334918976 } }, "network": { "sent": { "totalBytes": 215319585, "count": 440785, "bytesPerSecond": 270842.24528301886, "countPerSecond": 554.4465408805031, "topContributors": [ { "protocolId": 0, "packetId": 36, "packetName": "wc", "totalBytes": 202206306, "count": 6258 }, { "protocolId": 0, "packetId": 39, "packetName": "wf", "totalBytes": 8715483, "count": 3076 }, { "protocolId": 0, "packetId": 43, "packetName": "a", "totalBytes": 785979, "count": 87331 }, { "protocolId": 0, "packetId": 84, "packetName": "xx", "totalBytes": 769416, "count": 96177 }, { "protocolId": 0, "packetId": 67, "packetName": "xg", "totalBytes": 713997, "count": 16506 }, { "protocolId": 0, "packetId": 44, "packetName": "b", "totalBytes": 700084, "count": 63644 }, { "protocolId": 0, "packetId": 66, "packetName": "xf", "totalBytes": 299184, "count": 99728 }, { "protocolId": 0, "packetId": 104, "packetName": "yr", "totalBytes": 240584, "count": 8296 }, { "protocolId": 0, "packetId": 1, "packetName": "ur", "totalBytes": 210092, "count": 3964 }, { "protocolId": 0, "packetId": 106, "packetName": "yt", "totalBytes": 146967, "count": 3167 } ] }, "received": { "totalBytes": 245300, "count": 9757, "bytesPerSecond": 308.55345911949684, "countPerSecond": 12.272955974842768, "topContributors": [ { "protocolId": 0, "packetId": 20, "packetName": "a", "totalBytes": 126802, "count": 4877 }, { "protocolId": 0, "packetId": 21, "packetName": "b", "totalBytes": 94486, "count": 2779 }, { "protocolId": 0, "packetId": 29, "packetName": "aac", "totalBytes": 12788, "count": 1061 }, { "protocolId": 0, "packetId": 22, "packetName": "c", "totalBytes": 5820, "count": 582 }, { "protocolId": 0, "packetId": 43, "packetName": "aaq", "totalBytes": 1340, "count": 84 }, { "protocolId": 0, "packetId": 11, "packetName": "zn", "totalBytes": 1092, "count": 7 }, { "protocolId": 0, "packetId": 4, "packetName": "zg", "totalBytes": 817, "count": 15 }, { "protocolId": 0, "packetId": 49, "packetName": "aaw", "totalBytes": 754, "count": 29 }, { "protocolId": 0, "packetId": 18, "packetName": "zu", "totalBytes": 324, "count": 36 }, { "protocolId": 0, "packetId": 47, "packetName": "aau", "totalBytes": 310, "count": 155 } ] } }, "fileIO": { "write": { "totalBytes": 294934949, "count": 46351, "bytesPerSecond": 370987.3572327044, "countPerSecond": 58.30314465408805, "topContributors": [ { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.4.-3.mca", "totalBytes": 34747598 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.3.-4.mca", "totalBytes": 31623747 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.5.-3.mca", "totalBytes": 30329452 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.7.1.mca", "totalBytes": 27888959 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.1.-7.mca", "totalBytes": 26085826 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.4.-4.mca", "totalBytes": 25468557 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.2.-7.mca", "totalBytes": 17081713 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.3.-5.mca", "totalBytes": 15940932 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.1.-6.mca", "totalBytes": 10588334 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.2.-5.mca", "totalBytes": 8371447 } ] }, "read": { "totalBytes": 11076760, "count": 2540, "bytesPerSecond": 13933.031446540881, "countPerSecond": 3.1949685534591197, "topContributors": [ { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.1.-7.mca", "totalBytes": 4247552 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.2.-7.mca", "totalBytes": 2336022 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.2.-8.mca", "totalBytes": 1184889 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.1.-8.mca", "totalBytes": 835584 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.0.-7.mca", "totalBytes": 405504 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.5.-4.mca", "totalBytes": 393958 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\versions\\23w14a\\server-23w14a.jar", "totalBytes": 337179 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.1.-6.mca", "totalBytes": 303473 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.1.-7.mca", "totalBytes": 294912 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.5.-3.mca", "totalBytes": 166284 } ] } }, "serverTick": { "minMs": 3.087065, "averageMs": 13.459075012704174, "maxMs": 85.997792, "p99": 33.866509, "p90": 19.04135, "p75": 15.5300555, "p50": 11.724124 }, "threadAllocation": [ { "thread": "AWT-EventQueue-0", "bytesPerSecond": 54737.07526881721 }, { "thread": "AWT-Shutdown", "bytesPerSecond": 0.0 }, { "thread": "AWT-Windows", "bytesPerSecond": 53.46236559139785 }, { "thread": "Attach Listener", "bytesPerSecond": 0.0 }, { "thread": "C1 CompilerThread0", "bytesPerSecond": 2.0931899641577063 }, { "thread": "C1 CompilerThread1", "bytesPerSecond": 0.0 }, { "thread": "C1 CompilerThread2", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread0", "bytesPerSecond": 0.35842293906810035 }, { "thread": "C2 CompilerThread1", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread2", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread3", "bytesPerSecond": 0.0 }, { "thread": "Common-Cleaner", "bytesPerSecond": 0.0 }, { "thread": "DestroyJavaVM", "bytesPerSecond": 0.0 }, { "thread": "Finalizer", "bytesPerSecond": 0.0 }, { "thread": "IO-Worker-21", "bytesPerSecond": 485259.2831541219 }, { "thread": "IO-Worker-24", "bytesPerSecond": 401192.1433691756 }, { "thread": "IO-Worker-25", "bytesPerSecond": 416370.08928571426 }, { "thread": "IO-Worker-26", "bytesPerSecond": 462255.38624338625 }, { "thread": "IO-Worker-27", "bytesPerSecond": 178031.22424242424 }, { "thread": "IO-Worker-28", "bytesPerSecond": 30048.4 }, { "thread": "JFR Periodic Tasks", "bytesPerSecond": 213.10394265232975 }, { "thread": "JFR Recorder Thread", "bytesPerSecond": 0.0 }, { "thread": "JNA Cleaner", "bytesPerSecond": 0.0 }, { "thread": "Java2D Disposer", "bytesPerSecond": 0.0 }, { "thread": "Monitor Deflation Thread", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #0", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #1", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #2", "bytesPerSecond": 771278.0358422939 }, { "thread": "Notification Thread", "bytesPerSecond": 0.0 }, { "thread": "Reference Handler", "bytesPerSecond": 0.0 }, { "thread": "Server Watchdog", "bytesPerSecond": 0.0 }, { "thread": "Server thread", "bytesPerSecond": 1.0657521653046595E8 }, { "thread": "Service Thread", "bytesPerSecond": 0.0 }, { "thread": "Signal Dispatcher", "bytesPerSecond": 0.0 }, { "thread": "Sweeper thread", "bytesPerSecond": 0.0 }, { "thread": "Thread-1", "bytesPerSecond": 9.978494623655914 }, { "thread": "Timer hack thread", "bytesPerSecond": 0.0 }, { "thread": "TimerQueue", "bytesPerSecond": 525.5197132616487 }, { "thread": "Worker-Main-1", "bytesPerSecond": 8440797.634408602 }, { "thread": "Worker-Main-10", "bytesPerSecond": 8558584.960573476 }, { "thread": "Worker-Main-11", "bytesPerSecond": 8636077.992831541 }, { "thread": "Worker-Main-12", "bytesPerSecond": 8416927.268817205 }, { "thread": "Worker-Main-13", "bytesPerSecond": 8278840.774193549 }, { "thread": "Worker-Main-14", "bytesPerSecond": 8448847.856630825 }, { "thread": "Worker-Main-15", "bytesPerSecond": 8857449.720430108 }, { "thread": "Worker-Main-16", "bytesPerSecond": 8515517.806451613 }, { "thread": "Worker-Main-17", "bytesPerSecond": 8958867.082437277 }, { "thread": "Worker-Main-18", "bytesPerSecond": 8537526.035842294 }, { "thread": "Worker-Main-19", "bytesPerSecond": 8265380.516129033 }, { "thread": "Worker-Main-2", "bytesPerSecond": 9192029.720430108 }, { "thread": "Worker-Main-3", "bytesPerSecond": 8670236.8172043 }, { "thread": "Worker-Main-4", "bytesPerSecond": 8579954.508960573 }, { "thread": "Worker-Main-5", "bytesPerSecond": 8837203.655913979 }, { "thread": "Worker-Main-6", "bytesPerSecond": 8398165.491039427 }, { "thread": "Worker-Main-7", "bytesPerSecond": 8352778.265232975 }, { "thread": "Worker-Main-8", "bytesPerSecond": 8200596.329749104 }, { "thread": "Worker-Main-9", "bytesPerSecond": 9678602.46594982 } ], "chunkGen": { "durationNanosTotal": 1.272575328E12, "status": [ { "state": "noise", "count": 6516, "durationNanosTotal": 524719093300, "durationNanosAvg": 80527792, "durationNanosPercentiles": { "p99": 2.730253E8, "p90": 1.5518155E8, "p75": 9.3130375E7, "p50": 6.04114E7 }, "fastest": { "durationNanos": 700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 58, "chunkPosZ": 58, "worldPosX": 928, "worldPosZ": -3744 }, "slowest": { "durationNanos": 575178000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 50, "chunkPosZ": 50, "worldPosX": 800, "worldPosZ": -3008 }, "secondSlowest": { "durationNanos": 385089700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 137, "chunkPosZ": 137, "worldPosX": 2192, "worldPosZ": -1408 } }, { "state": "features", "count": 5904, "durationNanosTotal": 255147311900, "durationNanosAvg": 43216008, "durationNanosPercentiles": { "p99": 7.19762318E8, "p90": 8.097643E7, "p75": 3.8706225E7, "p50": 1.58998E7 }, "fastest": { "durationNanos": 87400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 58, "chunkPosZ": 58, "worldPosX": 928, "worldPosZ": -3568 }, "slowest": { "durationNanos": 1592460400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 94, "chunkPosZ": 94, "worldPosX": 1504, "worldPosZ": -2144 }, "secondSlowest": { "durationNanos": 1585405300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 92, "chunkPosZ": 92, "worldPosX": 1472, "worldPosZ": -2208 } }, { "state": "light", "count": 5323, "durationNanosTotal": 255019788200, "durationNanosAvg": 47909034, "durationNanosPercentiles": { "p99": 1.84685712E8, "p90": 8.118948E7, "p75": 5.8098E7, "p50": 3.83387E7 }, "fastest": { "durationNanos": 7331500, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 116, "chunkPosZ": 116, "worldPosX": 1856, "worldPosZ": -1680 }, "slowest": { "durationNanos": 1165021300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 257, "chunkPosZ": 257, "worldPosX": 4112, "worldPosZ": 752 }, "secondSlowest": { "durationNanos": 1164987100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 257, "chunkPosZ": 257, "worldPosX": 4112, "worldPosZ": 768 } }, { "state": "surface", "count": 6516, "durationNanosTotal": 87218090500, "durationNanosAvg": 13385219, "durationNanosPercentiles": { "p99": 3.0409875E7, "p90": 1.78038E7, "p75": 1.48588E7, "p50": 1.26516E7 }, "fastest": { "durationNanos": 200, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 43, "chunkPosZ": 43, "worldPosX": 688, "worldPosZ": -3328 }, "slowest": { "durationNanos": 547029400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 110, "chunkPosZ": 110, "worldPosX": 1760, "worldPosZ": -1680 }, "secondSlowest": { "durationNanos": 95869000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 153, "chunkPosZ": 153, "worldPosX": 2448, "worldPosZ": -1488 } }, { "state": "full", "count": 5561, "durationNanosTotal": 72148607900, "durationNanosAvg": 12974034, "durationNanosPercentiles": { "p99": 9.054642E7, "p90": 2.55534E7, "p75": 1.27605E7, "p50": 2344700.0 }, "fastest": { "durationNanos": 18100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 60, "chunkPosZ": 60, "worldPosX": 960, "worldPosZ": -3632 }, "slowest": { "durationNanos": 18898502600, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 234, "chunkPosZ": 234, "worldPosX": 3744, "worldPosZ": 896 }, "secondSlowest": { "durationNanos": 406033200, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 237, "chunkPosZ": 237, "worldPosX": 3792, "worldPosZ": 656 } }, { "state": "biomes", "count": 7151, "durationNanosTotal": 60055710800, "durationNanosAvg": 8398225, "durationNanosPercentiles": { "p99": 3.767725E7, "p90": 1.03244E7, "p75": 8341000.0, "p50": 7228600.0 }, "fastest": { "durationNanos": 200, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 48, "chunkPosZ": 48, "worldPosX": 768, "worldPosZ": -3264 }, "slowest": { "durationNanos": 163295700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 121, "chunkPosZ": 121, "worldPosX": 1936, "worldPosZ": -2160 }, "secondSlowest": { "durationNanos": 122428500, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 230, "chunkPosZ": 230, "worldPosX": 3680, "worldPosZ": 576 } }, { "state": "carvers", "count": 6516, "durationNanosTotal": 11716163800, "durationNanosAvg": 1798060, "durationNanosPercentiles": { "p99": 6495690.0, "p90": 3201750.0, "p75": 2218550.0, "p50": 1465300.0 }, "fastest": { "durationNanos": 200, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 59, "chunkPosZ": 59, "worldPosX": 944, "worldPosZ": -3520 }, "slowest": { "durationNanos": 32703400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 249, "chunkPosZ": 249, "worldPosX": 3984, "worldPosZ": 656 }, "secondSlowest": { "durationNanos": 28554300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 181, "chunkPosZ": 181, "worldPosX": 2896, "worldPosZ": -1408 } }, { "state": "structure_starts", "count": 14158, "durationNanosTotal": 5475087500, "durationNanosAvg": 386713, "durationNanosPercentiles": { "p99": 5612156.0, "p90": 34600.0, "p75": 17500.0, "p50": 9200.0 }, "fastest": { "durationNanos": 0, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 26, "chunkPosZ": 26, "worldPosX": 416, "worldPosZ": -3200 }, "slowest": { "durationNanos": 1115900300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 177, "chunkPosZ": 177, "worldPosX": 2832, "worldPosZ": -1392 }, "secondSlowest": { "durationNanos": 792089500, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 228, "chunkPosZ": 228, "worldPosX": 3648, "worldPosZ": 656 } }, { "state": "spawn", "count": 5557, "durationNanosTotal": 555543600, "durationNanosAvg": 99971, "durationNanosPercentiles": { "p99": 856896.0, "p90": 155720.0, "p75": 96200.0, "p50": 59500.0 }, "fastest": { "durationNanos": 0, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 62, "chunkPosZ": 62, "worldPosX": 992, "worldPosZ": -3424 }, "slowest": { "durationNanos": 19746300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 157, "chunkPosZ": 157, "worldPosX": 2512, "worldPosZ": -1376 }, "secondSlowest": { "durationNanos": 14090900, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 40, "chunkPosZ": 40, "worldPosX": 640, "worldPosZ": -3232 } }, { "state": "structure_references", "count": 7151, "durationNanosTotal": 492823000, "durationNanosAvg": 68916, "durationNanosPercentiles": { "p99": 258850.0, "p90": 105100.0, "p75": 65700.0, "p50": 40100.0 }, "fastest": { "durationNanos": 100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 70, "chunkPosZ": 70, "worldPosX": 1120, "worldPosZ": -3456 }, "slowest": { "durationNanos": 48793700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 97, "chunkPosZ": 97, "worldPosX": 1552, "worldPosZ": -2096 }, "secondSlowest": { "durationNanos": 31921400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 120, "chunkPosZ": 120, "worldPosX": 1920, "worldPosZ": -2272 } }, { "state": "liquid_carvers", "count": 6516, "durationNanosTotal": 17645700, "durationNanosAvg": 2708, "durationNanosPercentiles": { "p99": 12985.0, "p90": 5250.0, "p75": 3400.0, "p50": 2100.0 }, "fastest": { "durationNanos": 100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 58, "chunkPosZ": 58, "worldPosX": 928, "worldPosZ": -3744 }, "slowest": { "durationNanos": 94000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 169, "chunkPosZ": 169, "worldPosX": 2704, "worldPosZ": -1520 }, "secondSlowest": { "durationNanos": 93400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 149, "chunkPosZ": 149, "worldPosX": 2384, "worldPosZ": -1232 } }, { "state": "heightmaps", "count": 5557, "durationNanosTotal": 9461800, "durationNanosAvg": 1702, "durationNanosPercentiles": { "p99": 6300.0, "p90": 3300.0, "p75": 2200.0, "p50": 1400.0 }, "fastest": { "durationNanos": 0, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 60, "chunkPosZ": 60, "worldPosX": 960, "worldPosZ": -3504 }, "slowest": { "durationNanos": 38100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 138, "chunkPosZ": 138, "worldPosX": 2208, "worldPosZ": -1840 }, "secondSlowest": { "durationNanos": 18600, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 127, "chunkPosZ": 127, "worldPosX": 2032, "worldPosZ": -1664 } } ] } } [21:12:01] [Server thread/INFO]: Dumped recording summary to debug\jfr-report-server-2023-04-05-210232.json [21:12:06] [Server thread/INFO]: Started flight recorder profiling id(3):name(server-23w14a-2023-04-05-211205) - will dump to debug\server-2023-04-05-211205.jfr on exit or stop command [21:12:28] [Server thread/INFO]: [_Rhythmic: Generated structure "minecraft:shipwreck" at 3902, 73, 764] [21:12:42] [Server thread/INFO]: [_Rhythmic: Generated structure "minecraft:shipwreck" at 3893, 75, 781] [21:12:57] [Server thread/WARN]: Can't keep up! Is the server overloaded? Running 3789ms or 75 ticks behind [21:13:38] [Server thread/INFO]: Dumped flight recorder profiling to debug\server-2023-04-05-211205.jfr [21:13:38] [Server thread/INFO]: { "startedEpoch": 1680753524243, "endedEpoch": 1680754418609, "durationMs": 894366, "heap": { "allocationRateBytesPerSecond": 1.398709203478261E8, "gcCount": 19, "gcOverHeadPercent": 0.0018571815, "gcTotalDurationMs": 1661 }, "cpuPercent": { "jvm": { "min": 0.0, "average": 0.0011425400262750271, "max": 0.006218461319804192 }, "userJvm": { "min": 7.639214163646102E-4, "average": 0.011883128894906905, "max": 0.07180555164813995 }, "system": { "min": 0.0031194684561342, "average": 0.021953211926544706, "max": 0.15287211537361145 } }, "network": { "sent": { "totalBytes": 27842751, "count": 64549, "bytesPerSecond": 31144.01677852349, "countPerSecond": 72.20246085011186, "topContributors": [ { "protocolId": 0, "packetId": 36, "packetName": "wc", "totalBytes": 26760804, "count": 709 }, { "protocolId": 0, "packetId": 39, "packetName": "wf", "totalBytes": 483236, "count": 188 }, { "protocolId": 0, "packetId": 43, "packetName": "a", "totalBytes": 126081, "count": 14009 }, { "protocolId": 0, "packetId": 84, "packetName": "xx", "totalBytes": 117376, "count": 14672 }, { "protocolId": 0, "packetId": 104, "packetName": "yr", "totalBytes": 103066, "count": 3554 }, { "protocolId": 0, "packetId": 44, "packetName": "b", "totalBytes": 87307, "count": 7937 }, { "protocolId": 0, "packetId": 66, "packetName": "xf", "totalBytes": 42333, "count": 14111 }, { "protocolId": 0, "packetId": 1, "packetName": "ur", "totalBytes": 28196, "count": 532 }, { "protocolId": 0, "packetId": 106, "packetName": "yt", "totalBytes": 23107, "count": 509 }, { "protocolId": 0, "packetId": 67, "packetName": "xg", "totalBytes": 16530, "count": 643 } ] }, "received": { "totalBytes": 37662, "count": 1332, "bytesPerSecond": 42.12751677852349, "countPerSecond": 1.4899328859060403, "topContributors": [ { "protocolId": 0, "packetId": 20, "packetName": "a", "totalBytes": 19266, "count": 741 }, { "protocolId": 0, "packetId": 21, "packetName": "b", "totalBytes": 17578, "count": 517 }, { "protocolId": 0, "packetId": 22, "packetName": "c", "totalBytes": 290, "count": 29 }, { "protocolId": 0, "packetId": 4, "packetName": "zg", "totalBytes": 159, "count": 3 }, { "protocolId": 0, "packetId": 9, "packetName": "zl", "totalBytes": 86, "count": 4 }, { "protocolId": 0, "packetId": 49, "packetName": "aaw", "totalBytes": 78, "count": 3 }, { "protocolId": 0, "packetId": 29, "packetName": "aac", "totalBytes": 72, "count": 6 }, { "protocolId": 0, "packetId": 18, "packetName": "zu", "totalBytes": 63, "count": 7 }, { "protocolId": 0, "packetId": 30, "packetName": "aad", "totalBytes": 32, "count": 8 }, { "protocolId": 0, "packetId": 40, "packetName": "aan", "totalBytes": 9, "count": 3 } ] } }, "fileIO": { "write": { "totalBytes": 26538078, "count": 4471, "bytesPerSecond": 29684.65100671141, "countPerSecond": 5.001118568232662, "topContributors": [ { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.7.1.mca", "totalBytes": 8568934 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.1.mca", "totalBytes": 8205055 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.7.2.mca", "totalBytes": 2263855 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.6.1.mca", "totalBytes": 1920341 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.7.0.mca", "totalBytes": 1540083 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.2.mca", "totalBytes": 1328389 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.0.mca", "totalBytes": 954363 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.7.1.mca", "totalBytes": 548446 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.6.2.mca", "totalBytes": 522290 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.6.0.mca", "totalBytes": 462386 } ] }, "read": { "totalBytes": 1954289, "count": 490, "bytesPerSecond": 2186.0055928411634, "countPerSecond": 0.5480984340044742, "topContributors": [ { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.1.mca", "totalBytes": 786432 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.7.0.mca", "totalBytes": 491520 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.0.mca", "totalBytes": 475506 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.2.mca", "totalBytes": 123250 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.7.1.mca", "totalBytes": 66850 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\entities\\r.8.1.mca", "totalBytes": 8491 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\versions\\23w14a\\server-23w14a.jar", "totalBytes": 2240 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.9.3.mca", "totalBytes": 0 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\poi\\r.8.1.mca", "totalBytes": 0 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.7.3.mca", "totalBytes": 0 } ] } }, "serverTick": { "minMs": 7.240135, "averageMs": 10.729310333333332, "maxMs": 25.64528, "p99": 25.64528, "p90": 13.5769244, "p75": 10.7865195, "p50": 9.498961 }, "threadAllocation": [ { "thread": "AWT-EventQueue-0", "bytesPerSecond": 63050.541176470586 }, { "thread": "AWT-Shutdown", "bytesPerSecond": 0.0 }, { "thread": "AWT-Windows", "bytesPerSecond": 2976.1882352941175 }, { "thread": "Attach Listener", "bytesPerSecond": 0.0 }, { "thread": "C1 CompilerThread0", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread0", "bytesPerSecond": 0.0 }, { "thread": "Common-Cleaner", "bytesPerSecond": 0.0 }, { "thread": "DestroyJavaVM", "bytesPerSecond": 0.0 }, { "thread": "Finalizer", "bytesPerSecond": 0.0 }, { "thread": "IO-Worker-21", "bytesPerSecond": 206686.02352941176 }, { "thread": "IO-Worker-24", "bytesPerSecond": 287015.90588235296 }, { "thread": "IO-Worker-27", "bytesPerSecond": 276861.2705882353 }, { "thread": "IO-Worker-29", "bytesPerSecond": 277174.93333333335 }, { "thread": "JFR Periodic Tasks", "bytesPerSecond": 113.31764705882352 }, { "thread": "JFR Recorder Thread", "bytesPerSecond": 0.0 }, { "thread": "JNA Cleaner", "bytesPerSecond": 0.0 }, { "thread": "Java2D Disposer", "bytesPerSecond": 0.0 }, { "thread": "Monitor Deflation Thread", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #0", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #1", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #2", "bytesPerSecond": 665397.4588235294 }, { "thread": "Notification Thread", "bytesPerSecond": 0.0 }, { "thread": "Reference Handler", "bytesPerSecond": 0.0 }, { "thread": "Server Watchdog", "bytesPerSecond": 0.0 }, { "thread": "Server thread", "bytesPerSecond": 6.569682616470588E7 }, { "thread": "Service Thread", "bytesPerSecond": 0.0 }, { "thread": "Signal Dispatcher", "bytesPerSecond": 0.0 }, { "thread": "Sweeper thread", "bytesPerSecond": 0.0 }, { "thread": "Thread-1", "bytesPerSecond": 9.882352941176471 }, { "thread": "Timer hack thread", "bytesPerSecond": 0.0 }, { "thread": "TimerQueue", "bytesPerSecond": 527.6235294117647 }, { "thread": "Worker-Main-1", "bytesPerSecond": 3768030.870588235 }, { "thread": "Worker-Main-10", "bytesPerSecond": 3501963.9529411765 }, { "thread": "Worker-Main-11", "bytesPerSecond": 3271633.411764706 }, { "thread": "Worker-Main-12", "bytesPerSecond": 4635597.176470588 }, { "thread": "Worker-Main-13", "bytesPerSecond": 3174601.694117647 }, { "thread": "Worker-Main-14", "bytesPerSecond": 2502483.2 }, { "thread": "Worker-Main-15", "bytesPerSecond": 3750969.9764705882 }, { "thread": "Worker-Main-16", "bytesPerSecond": 5051574.964705883 }, { "thread": "Worker-Main-17", "bytesPerSecond": 4165029.3647058825 }, { "thread": "Worker-Main-18", "bytesPerSecond": 3064026.4470588234 }, { "thread": "Worker-Main-19", "bytesPerSecond": 4541783.623529412 }, { "thread": "Worker-Main-2", "bytesPerSecond": 4596387.9529411765 }, { "thread": "Worker-Main-3", "bytesPerSecond": 5122317.647058823 }, { "thread": "Worker-Main-4", "bytesPerSecond": 4591676.141176471 }, { "thread": "Worker-Main-5", "bytesPerSecond": 4170146.7294117645 }, { "thread": "Worker-Main-6", "bytesPerSecond": 3139974.4 }, { "thread": "Worker-Main-7", "bytesPerSecond": 3211018.9176470586 }, { "thread": "Worker-Main-8", "bytesPerSecond": 3578518.776470588 }, { "thread": "Worker-Main-9", "bytesPerSecond": 3190057.882352941 } ], "chunkGen": { "durationNanosTotal": 6.79339929E10, "status": [ { "state": "noise", "count": 438, "durationNanosTotal": 27611384800, "durationNanosAvg": 63039691, "durationNanosPercentiles": { "p99": 1.67678099E8, "p90": 9.69505E7, "p75": 7.2176325E7, "p50": 5.606565E7 }, "fastest": { "durationNanos": 21145000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 262, "chunkPosZ": 262, "worldPosX": 4192, "worldPosZ": 656 }, "slowest": { "durationNanos": 205954800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 226, "chunkPosZ": 226, "worldPosX": 3616, "worldPosZ": 640 }, "secondSlowest": { "durationNanos": 203426000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 265, "chunkPosZ": 265, "worldPosX": 4240, "worldPosZ": 512 } }, { "state": "light", "count": 382, "durationNanosTotal": 18118952100, "durationNanosAvg": 47431811, "durationNanosPercentiles": { "p99": 1.33544818E8, "p90": 8.483917E7, "p75": 5.8469525E7, "p50": 3.94236E7 }, "fastest": { "durationNanos": 7615200, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 266, "chunkPosZ": 266, "worldPosX": 4256, "worldPosZ": 704 }, "slowest": { "durationNanos": 632936800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 231, "chunkPosZ": 231, "worldPosX": 3696, "worldPosZ": 976 }, "secondSlowest": { "durationNanos": 145401100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 264, "chunkPosZ": 264, "worldPosX": 4224, "worldPosZ": 720 } }, { "state": "features", "count": 410, "durationNanosTotal": 10833097500, "durationNanosAvg": 26422189, "durationNanosPercentiles": { "p99": 1.42988715E8, "p90": 6.915906E7, "p75": 3.5910875E7, "p50": 1.333965E7 }, "fastest": { "durationNanos": 2957400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 244, "chunkPosZ": 244, "worldPosX": 3904, "worldPosZ": 448 }, "slowest": { "durationNanos": 187475100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 269, "chunkPosZ": 269, "worldPosX": 4304, "worldPosZ": 432 }, "secondSlowest": { "durationNanos": 148429300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 249, "chunkPosZ": 249, "worldPosX": 3984, "worldPosZ": 448 } }, { "state": "surface", "count": 438, "durationNanosTotal": 5120323400, "durationNanosAvg": 11690236, "durationNanosPercentiles": { "p99": 2.8960379E7, "p90": 1.514826E7, "p75": 1.315445E7, "p50": 1.10991E7 }, "fastest": { "durationNanos": 5399500, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 264, "chunkPosZ": 264, "worldPosX": 4224, "worldPosZ": 608 }, "slowest": { "durationNanos": 42939400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 267, "chunkPosZ": 267, "worldPosX": 4272, "worldPosZ": 560 }, "secondSlowest": { "durationNanos": 39050000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 270, "chunkPosZ": 270, "worldPosX": 4320, "worldPosZ": 640 } }, { "state": "biomes", "count": 466, "durationNanosTotal": 3031896600, "durationNanosAvg": 6506215, "durationNanosPercentiles": { "p99": 1.8134605E7, "p90": 8377150.0, "p75": 7077625.0, "p50": 6100600.0 }, "fastest": { "durationNanos": 2602700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 268, "chunkPosZ": 268, "worldPosX": 4288, "worldPosZ": 704 }, "slowest": { "durationNanos": 46216000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 238, "chunkPosZ": 238, "worldPosX": 3808, "worldPosZ": 1024 }, "secondSlowest": { "durationNanos": 32246800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 235, "chunkPosZ": 235, "worldPosX": 3760, "worldPosZ": 1024 } }, { "state": "full", "count": 384, "durationNanosTotal": 2394551700, "durationNanosAvg": 6235811, "durationNanosPercentiles": { "p99": 2.0561081E7, "p90": 9794730.0, "p75": 3516300.0, "p50": 320200.0 }, "fastest": { "durationNanos": 36700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 267, "chunkPosZ": 267, "worldPosX": 4272, "worldPosZ": 816 }, "slowest": { "durationNanos": 724215600, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 231, "chunkPosZ": 231, "worldPosX": 3696, "worldPosZ": 976 }, "secondSlowest": { "durationNanos": 624844200, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 232, "chunkPosZ": 232, "worldPosX": 3712, "worldPosZ": 976 } }, { "state": "carvers", "count": 438, "durationNanosTotal": 665084200, "durationNanosAvg": 1518457, "durationNanosPercentiles": { "p99": 4568992.0, "p90": 2739400.0, "p75": 1876250.0, "p50": 1314500.0 }, "fastest": { "durationNanos": 279900, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 264, "chunkPosZ": 264, "worldPosX": 4224, "worldPosZ": 752 }, "slowest": { "durationNanos": 4906800, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 226, "chunkPosZ": 226, "worldPosX": 3616, "worldPosZ": 800 }, "secondSlowest": { "durationNanos": 4864300, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 226, "chunkPosZ": 226, "worldPosX": 3616, "worldPosZ": 784 } }, { "state": "structure_starts", "count": 1171, "durationNanosTotal": 110912600, "durationNanosAvg": 94716, "durationNanosPercentiles": { "p99": 3588510.0, "p90": 20300.0, "p75": 10400.0, "p50": 4200.0 }, "fastest": { "durationNanos": 0, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 267, "chunkPosZ": 267, "worldPosX": 4272, "worldPosZ": 912 }, "slowest": { "durationNanos": 14399700, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 278, "chunkPosZ": 278, "worldPosX": 4448, "worldPosZ": 608 }, "secondSlowest": { "durationNanos": 11243400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 271, "chunkPosZ": 271, "worldPosX": 4336, "worldPosZ": 1104 } }, { "state": "spawn", "count": 382, "durationNanosTotal": 26591500, "durationNanosAvg": 69611, "durationNanosPercentiles": { "p99": 323422.0, "p90": 122400.0, "p75": 88725.0, "p50": 63050.0 }, "fastest": { "durationNanos": 2500, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 263, "chunkPosZ": 263, "worldPosX": 4208, "worldPosZ": 816 }, "slowest": { "durationNanos": 578900, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 247, "chunkPosZ": 247, "worldPosX": 3952, "worldPosZ": 976 }, "secondSlowest": { "durationNanos": 479400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 257, "chunkPosZ": 257, "worldPosX": 4112, "worldPosZ": 912 } }, { "state": "structure_references", "count": 466, "durationNanosTotal": 19806800, "durationNanosAvg": 42503, "durationNanosPercentiles": { "p99": 201385.0, "p90": 80800.0, "p75": 49625.0, "p50": 33000.0 }, "fastest": { "durationNanos": 7400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 269, "chunkPosZ": 269, "worldPosX": 4304, "worldPosZ": 640 }, "slowest": { "durationNanos": 288100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 268, "chunkPosZ": 268, "worldPosX": 4288, "worldPosZ": 944 }, "secondSlowest": { "durationNanos": 269200, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 225, "chunkPosZ": 225, "worldPosX": 3600, "worldPosZ": 720 } }, { "state": "liquid_carvers", "count": 438, "durationNanosTotal": 847400, "durationNanosAvg": 1934, "durationNanosPercentiles": { "p99": 10341.0, "p90": 3400.0, "p75": 2300.0, "p50": 1600.0 }, "fastest": { "durationNanos": 100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 262, "chunkPosZ": 262, "worldPosX": 4192, "worldPosZ": 784 }, "slowest": { "durationNanos": 16400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 226, "chunkPosZ": 226, "worldPosX": 3616, "worldPosZ": 704 }, "secondSlowest": { "durationNanos": 12600, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 257, "chunkPosZ": 257, "worldPosX": 4112, "worldPosZ": 1008 } }, { "state": "heightmaps", "count": 382, "durationNanosTotal": 544300, "durationNanosAvg": 1424, "durationNanosPercentiles": { "p99": 5771.0, "p90": 2500.0, "p75": 1800.0, "p50": 1200.0 }, "fastest": { "durationNanos": 100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 257, "chunkPosZ": 257, "worldPosX": 4112, "worldPosZ": 928 }, "slowest": { "durationNanos": 14100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 253, "chunkPosZ": 253, "worldPosX": 4048, "worldPosZ": 464 }, "secondSlowest": { "durationNanos": 7000, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 262, "chunkPosZ": 262, "worldPosX": 4192, "worldPosZ": 848 } } ] } } [21:13:38] [Server thread/INFO]: Dumped recording summary to debug\jfr-report-server-2023-04-05-211205.json [21:15:38] [Server thread/INFO]: Started flight recorder profiling id(4):name(server-23w14a-2023-04-05-211538) - will dump to debug\server-2023-04-05-211538.jfr on exit or stop command [21:16:00] [Server thread/WARN]: Can't keep up! Is the server overloaded? Running 2030ms or 40 ticks behind [21:16:23] [Server thread/WARN]: Can't keep up! Is the server overloaded? Running 3148ms or 62 ticks behind [21:17:21] [Server thread/INFO]: Dumped flight recorder profiling to debug\server-2023-04-05-211538.jfr [21:17:21] [Server thread/INFO]: { "startedEpoch": 1680753524243, "endedEpoch": 1680754641107, "durationMs": 1116863, "heap": { "allocationRateBytesPerSecond": 3.240305443137255E7, "gcCount": 5, "gcOverHeadPercent": 9.258074E-4, "gcTotalDurationMs": 1034 }, "cpuPercent": { "jvm": { "min": 0.0, "average": 6.647475680802017E-4, "max": 0.003132138168439269 }, "userJvm": { "min": 7.656444213353097E-4, "average": 0.004668139757704921, "max": 0.019546017050743103 }, "system": { "min": 0.0015351047040894628, "average": 0.012569368478143588, "max": 0.036819878965616226 } }, "network": { "sent": { "totalBytes": 302733, "count": 38457, "bytesPerSecond": 271.26612903225805, "countPerSecond": 34.45967741935484, "topContributors": [ { "protocolId": 0, "packetId": 44, "packetName": "b", "totalBytes": 104313, "count": 9483 }, { "protocolId": 0, "packetId": 43, "packetName": "a", "totalBytes": 47781, "count": 5309 }, { "protocolId": 0, "packetId": 66, "packetName": "xf", "totalBytes": 47274, "count": 15758 }, { "protocolId": 0, "packetId": 104, "packetName": "yr", "totalBytes": 24186, "count": 834 }, { "protocolId": 0, "packetId": 84, "packetName": "xx", "totalBytes": 22704, "count": 2838 }, { "protocolId": 0, "packetId": 1, "packetName": "ur", "totalBytes": 9222, "count": 174 }, { "protocolId": 0, "packetId": 106, "packetName": "yt", "totalBytes": 8260, "count": 178 }, { "protocolId": 0, "packetId": 82, "packetName": "xv", "totalBytes": 6910, "count": 878 }, { "protocolId": 0, "packetId": 98, "packetName": "yl", "totalBytes": 5580, "count": 180 }, { "protocolId": 0, "packetId": 2, "packetName": "us", "totalBytes": 4676, "count": 167 } ] }, "received": { "totalBytes": 20242, "count": 894, "bytesPerSecond": 18.13799283154122, "countPerSecond": 0.8010752688172043, "topContributors": [ { "protocolId": 0, "packetId": 21, "packetName": "b", "totalBytes": 9180, "count": 270 }, { "protocolId": 0, "packetId": 20, "packetName": "a", "totalBytes": 7436, "count": 286 }, { "protocolId": 0, "packetId": 11, "packetName": "zn", "totalBytes": 1523, "count": 66 }, { "protocolId": 0, "packetId": 22, "packetName": "c", "totalBytes": 1130, "count": 113 }, { "protocolId": 0, "packetId": 16, "packetName": "zs", "totalBytes": 408, "count": 34 }, { "protocolId": 0, "packetId": 43, "packetName": "aaq", "totalBytes": 196, "count": 33 }, { "protocolId": 0, "packetId": 49, "packetName": "aaw", "totalBytes": 104, "count": 4 }, { "protocolId": 0, "packetId": 38, "packetName": "aal", "totalBytes": 80, "count": 40 }, { "protocolId": 0, "packetId": 18, "packetName": "zu", "totalBytes": 54, "count": 6 }, { "protocolId": 0, "packetId": 47, "packetName": "aau", "totalBytes": 36, "count": 18 } ] } }, "fileIO": { "write": { "totalBytes": 317999, "count": 115, "bytesPerSecond": 284.9453405017921, "countPerSecond": 0.10304659498207885, "topContributors": [ { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.0.mca", "totalBytes": 132152 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.17.10.mca", "totalBytes": 16613 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.-14.18.mca", "totalBytes": 16089 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.-9.11.mca", "totalBytes": 16024 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.13.15.mca", "totalBytes": 15666 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.18.-11.mca", "totalBytes": 15514 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.28.6.mca", "totalBytes": 15162 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.1.mca", "totalBytes": 15144 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.-4.23.mca", "totalBytes": 14556 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.4.2.mca", "totalBytes": 8666 } ] }, "read": { "totalBytes": 168850, "count": 1002, "bytesPerSecond": 151.29928315412187, "countPerSecond": 0.8978494623655914, "topContributors": [ { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.0.0.mca", "totalBytes": 24576 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.-7.-12.mca", "totalBytes": 24576 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.-7.-7.mca", "totalBytes": 24576 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.0.mca", "totalBytes": 16384 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.5.-2.mca", "totalBytes": 16384 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.2.-7.mca", "totalBytes": 16384 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.8.3.mca", "totalBytes": 16384 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.3.3.mca", "totalBytes": 16384 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\versions\\23w14a\\server-23w14a.jar", "totalBytes": 13202 }, { "path": "C:\\Users\\[REMOVED]\\Desktop\\snapshot_server_tests\\.\\world\\region\\r.20.17.mca", "totalBytes": 0 } ] } }, "serverTick": { "minMs": 6.329637, "averageMs": 11.77444784, "maxMs": 312.380096, "p99": 46.38973532, "p90": 9.4563441, "p75": 8.591674, "p50": 8.1126325 }, "threadAllocation": [ { "thread": "AWT-EventQueue-0", "bytesPerSecond": 53340.32 }, { "thread": "AWT-Shutdown", "bytesPerSecond": 0.0 }, { "thread": "AWT-Windows", "bytesPerSecond": 0.0 }, { "thread": "Attach Listener", "bytesPerSecond": 0.0 }, { "thread": "C1 CompilerThread0", "bytesPerSecond": 0.0 }, { "thread": "C2 CompilerThread0", "bytesPerSecond": 0.0 }, { "thread": "Common-Cleaner", "bytesPerSecond": 0.0 }, { "thread": "DestroyJavaVM", "bytesPerSecond": 0.0 }, { "thread": "Finalizer", "bytesPerSecond": 0.0 }, { "thread": "IO-Worker-21", "bytesPerSecond": 6669.68 }, { "thread": "IO-Worker-24", "bytesPerSecond": 0.0 }, { "thread": "IO-Worker-27", "bytesPerSecond": 43192.24 }, { "thread": "IO-Worker-30", "bytesPerSecond": 85146.88 }, { "thread": "JFR Periodic Tasks", "bytesPerSecond": 115.04 }, { "thread": "JFR Recorder Thread", "bytesPerSecond": 0.0 }, { "thread": "JNA Cleaner", "bytesPerSecond": 0.0 }, { "thread": "Java2D Disposer", "bytesPerSecond": 0.0 }, { "thread": "Monitor Deflation Thread", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #0", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #1", "bytesPerSecond": 0.0 }, { "thread": "Netty Server IO #2", "bytesPerSecond": 187293.44 }, { "thread": "Notification Thread", "bytesPerSecond": 0.0 }, { "thread": "Reference Handler", "bytesPerSecond": 0.0 }, { "thread": "Server Watchdog", "bytesPerSecond": 0.0 }, { "thread": "Server thread", "bytesPerSecond": 3.166311928E7 }, { "thread": "Service Thread", "bytesPerSecond": 0.0 }, { "thread": "Signal Dispatcher", "bytesPerSecond": 0.0 }, { "thread": "Sweeper thread", "bytesPerSecond": 0.0 }, { "thread": "Thread-1", "bytesPerSecond": 5.6 }, { "thread": "Timer hack thread", "bytesPerSecond": 0.0 }, { "thread": "TimerQueue", "bytesPerSecond": 530.64 }, { "thread": "Worker-Main-1", "bytesPerSecond": 60764.4 }, { "thread": "Worker-Main-10", "bytesPerSecond": 128743.04 }, { "thread": "Worker-Main-11", "bytesPerSecond": 19526.32 }, { "thread": "Worker-Main-12", "bytesPerSecond": 0.0 }, { "thread": "Worker-Main-13", "bytesPerSecond": 23812.0 }, { "thread": "Worker-Main-14", "bytesPerSecond": 418.56 }, { "thread": "Worker-Main-15", "bytesPerSecond": 20624.96 }, { "thread": "Worker-Main-16", "bytesPerSecond": 0.0 }, { "thread": "Worker-Main-17", "bytesPerSecond": 0.0 }, { "thread": "Worker-Main-18", "bytesPerSecond": 0.0 }, { "thread": "Worker-Main-19", "bytesPerSecond": 0.0 }, { "thread": "Worker-Main-2", "bytesPerSecond": 53459.52 }, { "thread": "Worker-Main-3", "bytesPerSecond": 19116.64 }, { "thread": "Worker-Main-4", "bytesPerSecond": 0.0 }, { "thread": "Worker-Main-5", "bytesPerSecond": 0.0 }, { "thread": "Worker-Main-6", "bytesPerSecond": 0.0 }, { "thread": "Worker-Main-7", "bytesPerSecond": 163417.2 }, { "thread": "Worker-Main-8", "bytesPerSecond": 0.0 }, { "thread": "Worker-Main-9", "bytesPerSecond": 92685.44 } ], "chunkGen": { "durationNanosTotal": 3.506797E8, "status": [ { "state": "structure_starts", "count": 14, "durationNanosTotal": 350679700, "durationNanosAvg": 25048550, "durationNanosPercentiles": { "p99": 3.3792489E7, "p90": 3.33324E7, "p75": 3.0640175E7, "p50": 2.731585E7 }, "fastest": { "durationNanos": 13377500, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": -280, "chunkPosZ": -280, "worldPosX": -4480, "worldPosZ": 5744 }, "slowest": { "durationNanos": 33806100, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 293, "chunkPosZ": 293, "worldPosX": 4688, "worldPosZ": -3280 }, "secondSlowest": { "durationNanos": 33701400, "level": "ResourceKey[minecraft:dimension / minecraft:overworld]", "chunkPosX": 107, "chunkPosZ": 107, "worldPosX": 1712, "worldPosZ": 1328 } } ] } } [21:17:21] [Server thread/INFO]: Dumped recording summary to debug\jfr-report-server-2023-04-05-211538.json [21:21:11] [Server thread/INFO]: Stopping the server [21:21:11] [Server thread/INFO]: Stopping server [21:21:11] [Server thread/INFO]: Saving players [21:21:11] [Server thread/INFO]: Saving worlds [21:21:12] [Server thread/INFO]: Saving chunks for level 'ServerLevel[world]'/minecraft:overworld [21:21:12] [Server thread/INFO]: Saving chunks for level 'ServerLevel[world]'/minecraft:the_nether [21:21:12] [Server thread/INFO]: Saving chunks for level 'ServerLevel[world]'/minecraft:the_end [21:21:12] [Server thread/INFO]: ThreadedAnvilChunkStorage (world): All chunks are saved [21:21:12] [Server thread/INFO]: ThreadedAnvilChunkStorage (DIM-1): All chunks are saved [21:21:12] [Server thread/INFO]: ThreadedAnvilChunkStorage (DIM1): All chunks are saved [21:21:12] [Server thread/INFO]: ThreadedAnvilChunkStorage: All dimensions are saved