search

carlquistb / FormulaCraft

An SMS-based service for running Minecraft server on AWS.
MIT License
0 stars 1 forks source link

player listed twice after leaving and re-entering the game #54

Closed carlquistb closed 3 years ago

carlquistb commented 4 years ago

mclog.txt 

[23:34:59] [Server thread/ERROR]: No key position_predicate in MapLike[{location_predicate:{predicate_type:"minecraft:block_match",block:"minecraft:water"},output_state:{Properties:{level:"0"},Name:"minecraft:water"},input_predicate:{predicate_type:"minecraft:block_match",block:"minecraft:dirt"}}]; No key position_predicate in MapLike[{location_predicate:{predicate_type:"minecraft:block_match",block:"minecraft:water"},output_state:{Properties:{level:"0"},Name:"minecraft:water"},input_predicate:{predicate_type:"minecraft:block_match",block:"minecraft:grass_block"}}]; No key position_predicate in MapLike[{location_predicate:{predicate_type:"minecraft:always_true"},output_state:{Properties:{snowy:"false"},Name:"minecraft:grass_block"},input_predicate:{predicate_type:"minecraft:random_block_match",probability:0.1f,block:"minecraft:grass_path"}}]; No key position_predicate in MapLike[{location_predicate:{predicate_type:"minecraft:block_match",block:"minecraft:water"},output_state:{Name:"minecraft:oak_planks"},input_predicate:{predicate_type:"minecraft:block_match",block:"minecraft:grass_path"}}]
[05:17:28] [Server thread/INFO]: okazninja fell out of the world
[05:17:29] [Server thread/FATAL]: Error executing task on Server
java.lang.NullPointerException: null
        at yv.b(SourceFile:202) ~[server.jar:?]
        at yp.a(SourceFile:939) ~[server.jar:?]
        at zb.a(SourceFile:467) ~[server.jar:?]
        at zv.a(SourceFile:867) ~[server.jar:?]
        at rs.a(SourceFile:122) ~[server.jar:?]
        at rs$a.a(SourceFile:56) ~[server.jar:?]
        at nk.a(SourceFile:21) ~[server.jar:?]
        at uy.run(SourceFile:18) ~[server.jar:?]
        at amn.c(SourceFile:144) ~[server.jar:?]
        at amr.c(SourceFile:23) ~[server.jar:?]
        at net.minecraft.server.MinecraftServer.b(SourceFile:763) ~[server.jar:?]
        at net.minecraft.server.MinecraftServer.c(SourceFile:154) ~[server.jar:?]
        at amn.x(SourceFile:118) ~[server.jar:?]
        at net.minecraft.server.MinecraftServer.aZ(SourceFile:745) ~[server.jar:?]
        at net.minecraft.server.MinecraftServer.x(SourceFile:739) ~[server.jar:?]
        at amn.c(SourceFile:127) ~[server.jar:?]
        at net.minecraft.server.MinecraftServer.w(SourceFile:724) ~[server.jar:?]
        at net.minecraft.server.MinecraftServer.v(SourceFile:676) ~[server.jar:?]
        at net.minecraft.server.MinecraftServer.a(SourceFile:256) ~[server.jar:?]
        at java.lang.Thread.run(Thread.java:748) [?:1.8.0_265]
[05:18:37] [Server thread/INFO]: <okazninja> supersave
[05:18:37] [Server thread/INFO]: [Server] Save finishedsay local save initiated
[05:18:37] [Server thread/INFO]: Saving the game (this may take a moment!)
[05:18:37] [Server thread/INFO]: Saved the game
[05:18:42] [Server thread/INFO]: [Server] cloud save initiated
[05:18:42] [Server thread/INFO]: Automatic saving is now disabled
[05:18:46] [Server thread/INFO]: Automatic saving is now enabled
[05:18:58] [Server thread/INFO]: okazninja lost connection: Disconnected
[05:18:58] [Server thread/INFO]: okazninja left the game

adjacent log output from journalctl

Sep 20 23:20:34 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 20 23:25:35 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [ 'okazninja', 'Xenobo' ]
Sep 20 23:35:34 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 20 23:40:35 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [ 'okazninja', 'Xenobo' ]
Sep 20 23:50:34 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 21 03:50:34 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 21 04:02:07 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [ 'okazninja' ]
Sep 21 04:05:34 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 21 04:06:46 ip-172-32-5-29.us-west-2.compute.internal node[3109]: okazninja
Sep 21 04:20:35 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 21 04:21:46 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [ 'okazninja', 'okazninja' ]
Sep 21 04:35:35 ip-172-32-5-29.us-west-2.compute.inte:qqrnal node[3109]: [mineShell] Uploading world...
Sep 21 04:36:46 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [ 'okazninja', 'okazninja' ]
Sep 21 04:50:35 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 21 04:51:46 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [ 'okazninja', 'okazninja' ]
Sep 21 05:05:35 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 21 05:06:46 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [ 'okazninja', 'okazninja' ]
Sep 21 05:15:52 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] player initiated save
Sep 21 05:15:57 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 21 05:18:37 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] player initiated save
Sep 21 05:18:42 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 21 05:20:35 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...

grep 'the game' mclog.txt (might help figure out why okazninja was listed twice)

[22:51:44] [Server thread/INFO]: okazninja joined the game
[22:55:35] [Server thread/INFO]: Xenobo joined the game
[00:03:24] [Server thread/INFO]: okazninja left the game
[00:13:39] [Server thread/INFO]: Saving the game (this may take a moment!)
[00:13:39] [Server thread/INFO]: Saved the game
[00:31:12] [Server thread/INFO]: Saving the game (this may take a moment!)
[00:31:12] [Server thread/INFO]: Saved the game
[00:32:06] [Server thread/INFO]: Xenobo left the game
[04:06:46] [Server thread/INFO]: okazninja joined the game
[05:15:52] [Server thread/INFO]: Saving the game (this may take a moment!)
[05:15:52] [Server thread/INFO]: Saved the game
[05:18:37] [Server thread/INFO]: Saving the game (this may take a moment!)
[05:18:37] [Server thread/INFO]: Saved the game
[05:18:58] [Server thread/INFO]: okazninja left the game

okazninja left the game at 00:03:34, and it was not caught by the playerwatcher

Sep 20 23:50:34 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 20 23:55:35 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [ 'okazninja', 'Xenobo' ]
Sep 21 00:05:34 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...
Sep 21 00:10:35 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [ 'okazninja', 'Xenobo' ]
Sep 21 00:13:39 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] player initiated save
Sep 21 00:13:44 ip-172-32-5-29.us-west-2.compute.internal node[3109]: [mineShell] Uploading world...

mclog.txt from adjacent to 00:03:24

[00:03:14] [Server thread/INFO]: <okazninja> k i'll be back
[00:03:24] [Server thread/INFO]: okazninja lost connection: Disconnected
[00:03:24] [Server thread/INFO]: okazninja left the game
[00:13:39] [Server thread/INFO]: <Xenobo> supersave

I don't see a reason why the playerwatcher did not catch that he left...

I'm not super concerned regarding this error, because the files on S3 at the time of opening this server were not from our most recent updates.

If it happens again, we should look into it more.

carlquistb commented 3 years ago

error was not repeatable on currently deployed version.