Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

First chunk load extremely slow #141

Open
XLordalX opened this issue Jul 12, 2022 · 12 comments
Open

First chunk load extremely slow #141

XLordalX opened this issue Jul 12, 2022 · 12 comments
Assignees
Labels
FURTHER INPUT Extra attention is needed

Comments

@XLordalX
Copy link

XLordalX commented Jul 12, 2022

Describe the issue
The first world loaded by ASWM takes a lot of time to load the spawn chunk (world loading itself is fast). Any world loaded after the first one does not have this issue (it's super fast).

Spigot version
This server is running Paper version git-Paper-"e294802" (MC: 1.19) (Implementing API version 1.19-R0.1-SNAPSHOT) (Git: e294802)

Plugin version
2.9.0

How to reproduce

Load a world using the following code:

val swm = SWMPlugin.getInstance()

val slimeWorld = swm.loadWorld(
    slimeLoader,
    worldName,
    false,
    SlimePropertyMap().apply {
        setValue(SlimeProperties.DIFFICULTY, "normal")
    }
)

swm.generateWorld(slimeWorld)

val world = Bukkit.getWorld(worldName)
    ?: throw java.lang.IllegalStateException("Generated slime world does not exist.")

world.setGameRule(GameRule.ANNOUNCE_ADVANCEMENTS, false)

Crash reports (if available)

Not actually a crash, the chunk just takes a lot of time to load:

[15:23:15 ERROR]: The server has not responded for 10 seconds! Creating thread dump
[15:23:15 ERROR]: ------------------------------
[15:23:15 ERROR]: Server thread dump (Look for plugins here before reporting to Paper!):
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] Chunk wait task info below:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] -1,-1 in 'e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] Load Task - none
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] Save Task - none
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] Chunk Ticket Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread] Chunk Neighbors:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   -2,-2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   0,0 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Ticket Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Neighbors:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     -1,1 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Ticket Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Neighbors:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       0,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       -1,0 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Ticket Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Neighbors:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         0,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         -1,1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         -2,1 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         0,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Neighbors: (Can't show, too deeply nested)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         0,1 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Neighbors: (Can't show, too deeply nested)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         -1,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         -2,0 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         -2,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       -2,1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       0,1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       -2,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       -2,2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       -1,2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       0,2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     -1,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     1,0 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Ticket Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     Chunk Neighbors:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       0,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       2,0 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       2,1 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       2,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       0,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       0,1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       1,1 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Ticket Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Neighbors:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         0,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         1,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         2,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         2,1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         0,1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         1,2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         2,2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         0,2 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       1,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Ticket Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]       Chunk Neighbors:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         2,-2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         0,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         1,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         2,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         2,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         0,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         1,-2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         0,-2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]         Chunk Holder Priority - 46
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     0,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     0,1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     -1,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     1,1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]     1,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   -1,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   0,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   -2,0 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   0,-2 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   -2,-1 in e6961694-053c-4ce2-9b8e-c50c966955f1 (CIRCULAR)
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   -1,-2 in e6961694-053c-4ce2-9b8e-c50c966955f1:
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Holder - non-null
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Status - minecraft:full
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Ticket Status - minecraft:features
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Holder Status - minecraft:liquid_carvers
[15:23:15 ERROR]: [com.destroystokyo.paper.io.PaperFileIOThread]   Chunk Holder Priority - 46
[15:23:15 ERROR]: ------------------------------
[15:23:15 ERROR]: Current Thread: Server thread
[15:23:15 ERROR]:       PID: 24 | Suspended: false | Native: false | State: TIMED_WAITING
[15:23:15 ERROR]:       Stack:
[15:23:15 ERROR]:               [email protected]/jdk.internal.misc.Unsafe.park(Native Method)
[15:23:15 ERROR]:               [email protected]/java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:252)
[15:23:15 ERROR]:               net.minecraft.util.thread.BlockableEventLoop.waitForTasks(BlockableEventLoop.java:148)
[15:23:15 ERROR]:               net.minecraft.util.thread.BlockableEventLoop.managedBlock(BlockableEventLoop.java:137)
[15:23:15 ERROR]:               net.minecraft.server.level.ServerChunkCache.getChunk(ServerChunkCache.java:661)
[15:23:15 ERROR]:               net.minecraft.world.level.chunk.ChunkSource.getChunk(ChunkSource.java:13)
[15:23:15 ERROR]:               io.papermc.paper.util.CollisionUtil.getCollisionsForBlocksOrWorldBorder(CollisionUtil.java:483)
[15:23:15 ERROR]:               net.minecraft.world.level.CollisionGetter.noCollision(CollisionGetter.java:40)
[15:23:15 ERROR]:               net.minecraft.server.players.PlayerList.respawn(PlayerList.java:949)
[15:23:15 ERROR]:               net.minecraft.server.players.PlayerList.respawn(PlayerList.java:829)
[15:23:15 ERROR]:               org.bukkit.craftbukkit.v1_19_R1.entity.CraftPlayer.teleport(CraftPlayer.java:1197)
[15:23:15 ERROR]:               org.bukkit.craftbukkit.v1_19_R1.entity.CraftEntity.teleport(CraftEntity.java:569)
[15:23:15 ERROR]:               ShadedCoreBukkit.jar//gg.shaded.core.bukkit.entity.EntityKt.ejectAndTeleport(Entity.kt:17)
[15:23:15 ERROR]:               Shyblock.jar//gg.shaded.shyblock.island.locator.LocalIslandLocation.summon$lambda-0(LocalIslandLocation.kt:24)
[15:23:15 ERROR]:               Shyblock.jar//gg.shaded.shyblock.island.locator.LocalIslandLocation$$Lambda$7777/0x00000008023c2cf0.accept(Unknown Source)
[15:23:15 ERROR]:               ShadedCoreBukkit.jar//io.reactivex.rxjava3.internal.operators.single.SingleDoOnSuccess$DoOnSuccess.onSuccess(SingleDoOnSuccess.java:54)
[15:23:15 ERROR]:               ShadedCoreBukkit.jar//io.reactivex.rxjava3.internal.operators.single.SingleObserveOn$ObserveOnSingleObserver.run(SingleObserveOn.java:81)
[15:23:15 ERROR]:               ShadedCoreBukkit.jar//io.reactivex.rxjava3.internal.schedulers.ExecutorScheduler$ExecutorWorker$BooleanRunnable.run(ExecutorScheduler.java:324)
[15:23:15 ERROR]:               org.bukkit.craftbukkit.v1_19_R1.scheduler.CraftTask.run(CraftTask.java:101)
[15:23:15 ERROR]:               org.bukkit.craftbukkit.v1_19_R1.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:483)
[15:23:15 ERROR]:               net.minecraft.server.MinecraftServer.tickChildren(MinecraftServer.java:1490)
[15:23:15 ERROR]:               net.minecraft.server.dedicated.DedicatedServer.tickChildren(DedicatedServer.java:446)
[15:23:15 ERROR]:               net.minecraft.server.MinecraftServer.tickServer(MinecraftServer.java:1414)
[15:23:15 ERROR]:               net.minecraft.server.MinecraftServer.runServer(MinecraftServer.java:1187)
[15:23:15 ERROR]:               net.minecraft.server.MinecraftServer.lambda$spin$0(MinecraftServer.java:302)
[15:23:15 ERROR]:               net.minecraft.server.MinecraftServer$$Lambda$4504/0x000000080156f080.run(Unknown Source)
[15:23:15 ERROR]:               [email protected]/java.lang.Thread.run(Thread.java:833)
@YouHaveTrouble
Copy link

I also experienced this. Never to the point of watchdog reporting a hang, but it seems to happen when no worlds have been loaded on server boot, first world load takes extremely long, subsequent ones are fast as normal

@XLordalX
Copy link
Author

I also experienced this. Never to the point of watchdog reporting a hang, but it seems to happen when no worlds have been loaded on server boot, first world load takes extremely long, subsequent ones are fast as normal

Were you ever able to figure out what causes this behavior?

@HookWoods
Copy link

Yup I had an experience like that long time ago, and found it was coming from ChunkTaskPriorityQueueSorter getProcessor in ChunkMap constructor, so it's coming from Minecraft with SWM, but don't know why

@ComputerNerd100
Copy link
Collaborator

Thanks for this report and for including the thread dump. It seems we might need to dig into what Minecraft is doing in 1.19 a little bit more - we've already had issues with default world overriding so I'll see if we can work out what's causing this to take so long.
Can I ask how big the world is you're loading? And can we get a copy of the world too so that we can test with this world during debugging?

@YouHaveTrouble
Copy link

I don't think the size of the world matters, it happened to me with a 1 chunk world with just a 16x16 stone box in it.
I suspect that if there isn't a world loaded on boot there are some caches that fill up for the first time they're used and that causes the first world loaded to halt the thread. Just a theory, I didn't have time to look into it

@XLordalX
Copy link
Author

Thanks for this report and for including the thread dump. It seems we might need to dig into what Minecraft is doing in 1.19 a little bit more - we've already had issues with default world overriding so I'll see if we can work out what's causing this to take so long. Can I ask how big the world is you're loading? And can we get a copy of the world too so that we can test with this world during debugging?

Here it is in Base64. It's a small starter island. https://www.toptal.com/developers/hastebin/raw/gumugifazo

@Owen1212055
Copy link
Collaborator

Is this only on 1.19?

@XLordalX
Copy link
Author

Is this only on 1.19?

No, I had the same issue on 1.18

@Owen1212055
Copy link
Collaborator

Can you please send your config files? Does this happen each time btw?

@XLordalX
Copy link
Author

Can you please send your config files? Does this happen each time btw?

It happens every first time after a reboot. So in other words, I restart the server, I load a world using the ASWM API and I teleport a player to the world's spawn chunk. The teleport then causes the chunk to load and this is the part that takes around ~15 seconds and freezes the server. But again, only the first time after a reboot.

Paper config: https://pastebin.com/w7wFA2MH
Spigot config: https://pastebin.com/1ZeJWaaj

I'm assuming you meant those config files? If you need anything else, let me know.

@tehchuanyeow
Copy link

I'm having issues with the overworld overriding the worlds as well. And often before loading it lags the whole server.

@Paul19988
Copy link
Owner

Overriding default worlds on 1.19 does not work, it's an issue we cannot get around at this time I'm afraid.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
FURTHER INPUT Extra attention is needed
Projects
None yet
Development

No branches or pull requests

7 participants