search

CloudburstMC / Nukkit

Cloudburst Nukkit - Nuclear-Powered Minecraft: Bedrock Edition Server Software
https://cloudburstmc.org
GNU General Public License v3.0
1.22k stars 419 forks source link

I cant Login in 308 Version #615

Open tyvioto opened 5 years ago

tyvioto commented 5 years ago

Actual Behavior

I can't login after update to 308

Trace:

org.iq80.leveldb.impl.DbImpl$BackgroundProcessingException: java.lang.RuntimeException: java.nio.channels.ClosedChannelException
        at org.iq80.leveldb.impl.DbImpl.checkBackgroundException(DbImpl.java:369) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.writeInternal(DbImpl.java:627) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.put(DbImpl.java:598) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.put(DbImpl.java:592) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.Server.updateName(Server.java:1523) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.Player.processLogin(Player.java:1899) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.Player.handleDataPacket(Player.java:2194) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at java.util.ArrayList.forEach(ArrayList.java:1249) ~[?:1.8.0_65]
        at cn.nukkit.network.Network.processPackets(Network.java:179) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.network.Network.processBatch(Network.java:161) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.Player.handleDataPacket(Player.java:2067) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.network.RakNetInterface.handleEncapsulated(RakNetInterface.java:157) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.raknet.server.ServerHandler.handlePacket(ServerHandler.java:132) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.network.RakNetInterface.process(RakNetInterface.java:66) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.network.Network.processInterfaces(Network.java:76) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.Server.tick(Server.java:1105) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.Server.tickProcessor(Server.java:885) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.Server.start(Server.java:862) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.Server.<init>(Server.java:553) [nukkit-1.0-SNAPSHOT.jar:?]
        at cn.nukkit.Nukkit.main(Nukkit.java:95) [nukkit-1.0-SNAPSHOT.jar:?]
Caused by: java.lang.RuntimeException: java.nio.channels.ClosedChannelException
        at com.google.common.base.Throwables.propagate(Throwables.java:240) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.table.Table.openBlock(Table.java:81) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextBlock(TableIterator.java:102) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextElement(TableIterator.java:79) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.InternalTableIterator.getNextElement(InternalTableIterator.java:51) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.resetPriorityQueue(Level0Iterator.java:88) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.<init>(Level0Iterator.java:54) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.VersionSet.makeInputIterator(VersionSet.java:209) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.doCompactionWork(DbImpl.java:947) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCompaction(DbImpl.java:430) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCall(DbImpl.java:383) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.access$100(DbImpl.java:57) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:355) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:350) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_65]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) ~[?:1.8.0_65]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) ~[?:1.8.0_65]
        at java.lang.Thread.run(Thread.java:745) ~[?:1.8.0_65]
Caused by: java.nio.channels.ClosedChannelException
        at sun.nio.ch.FileChannelImpl.ensureOpen(FileChannelImpl.java:110) ~[?:1.8.0_65]
        at sun.nio.ch.FileChannelImpl.read(FileChannelImpl.java:720) ~[?:1.8.0_65]
        at org.iq80.leveldb.table.FileChannelTable.read(FileChannelTable.java:114) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.table.FileChannelTable.readBlock(FileChannelTable.java:57) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.table.Table.openBlock(Table.java:78) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextBlock(TableIterator.java:102) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextElement(TableIterator.java:79) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.InternalTableIterator.getNextElement(InternalTableIterator.java:51) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.resetPriorityQueue(Level0Iterator.java:88) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.<init>(Level0Iterator.java:54) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.VersionSet.makeInputIterator(VersionSet.java:209) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.doCompactionWork(DbImpl.java:947) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCompaction(DbImpl.java:430) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCall(DbImpl.java:383) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl.access$100(DbImpl.java:57) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:355) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:350) ~[nukkit-1.0-SNAPSHOT.jar:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_65]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) ~[?:1.8.0_65]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) ~[?:1.8.0_65]
        at java.lang.Thread.run(Thread.java:745) ~[?:1.8.0_65]
--- Want to back this issue? **[Post a bounty on it!](https://www.bountysource.com/issues/71550184-i-cant-login-in-308-version?utm_campaign=plugin&utm_content=tracker%2F80651332&utm_medium=issues&utm_source=github)** We accept bounties via [Bountysource](https://www.bountysource.com/?utm_campaign=plugin&utm_content=tracker%2F80651332&utm_medium=issues&utm_source=github).
SupremeMortal commented 5 years ago

I can't reproduce this. Do you have a clean installation on the latest version?

DaMatrix commented 5 years ago

What system are you running, what java version, do you have write access to the place where the world is stored, and is the world stored on a reliable drive (i.e. one that won't be unmounted randomly)? I can't think of why the channel would be closed unless something was happening to the world folder externally.

tyvioto commented 5 years ago

Hello,

Me installation is not clear, i have autoupdate script for JAR change, and i USE existing word and existing Player Data. I make couple of tests and i Find problem in some Player Data. When I remove PLayers data server work without problem.

Java Version : ava version "1.8.0_65" Java(TM) SE Runtime Environment (build 1.8.0_65-b17) Java HotSpot(TM) Client VM (build 25.65-b01, mixed mode)

OS is Raspbian with kernel : 4.14.79-v7+ GNU/Linux Permision on player data look OK -> rw

timnolte commented 5 years ago

I just updated too, since we could no longer connect since the Minecraft clients all updated to 1.10. I'm also running on a Raspbian install.

Jessie, kernel 4.1.19-v7+ build 858 OpenJDK 1.8.0_40

timnolte commented 5 years ago

In an effort to resolve this issue as I have this suspicion it make be related to a JDK version I decided to upgrade to the Stretch build of Raspbian, and install OpenJDK 9. We'll see what happens with this.

timnolte commented 5 years ago

Just to follow up even after upgrading it still dies with the same ClosedChannelException. Perhaps this is a difference between using an Oracle JDK vs the OpenJDK?

My versions now: Raspbian Stretch, kernel 4.14.98-v7+ build 1200 OpenJDK 9 (raspbian 9, 0-9b181)

timnolte commented 5 years ago

Here's my log tail showing the same failure. Pretty much the same thing regardless of which JDK I try.

root@presspi:~# systemctl start nukkit
root@presspi:~# tail -f /opt/minecraft/logs/server.log
2019-03-20 19:03:02.197 [main] INFO  - Loaded 954 recipes.
2019-03-20 19:03:02.203 [main] INFO  - Successfully loaded 0 resource packs
2019-03-20 19:03:02.487 [main] INFO  - Preparing level "§aNolte Minecraft World§f"
2019-03-20 19:03:02.701 [RakNet Thread #14] INFO  - Epoll is unavailable. Reverting to NioEventLoop.
2019-03-20 19:03:02.734 [main] INFO  - Preparing level "§anether§f"
2019-03-20 19:03:02.847 [main] INFO  - Starting GS4 status listener
2019-03-20 19:03:02.849 [main] INFO  - Setting query port to 19132
2019-03-20 19:03:02.853 [main] INFO  - Query is running on 0.0.0.0:19132
2019-03-20 19:03:02.855 [main] INFO  - Default game type: Survival Mode
2019-03-20 19:03:02.857 [main] INFO  - Done (5.827s)! For help, type "help" or "?"
2019-03-20 19:37:21.561 [main] ERROR - Throwing
org.iq80.leveldb.impl.DbImpl$BackgroundProcessingException: java.lang.RuntimeException: java.nio.channels.ClosedChannelException
        at org.iq80.leveldb.impl.DbImpl.checkBackgroundException(DbImpl.java:369) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.writeInternal(DbImpl.java:627) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.put(DbImpl.java:598) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.put(DbImpl.java:592) ~[nukkit.jar:?]
        at cn.nukkit.Server.updateName(Server.java:1523) ~[nukkit.jar:?]
        at cn.nukkit.Player.processLogin(Player.java:1899) ~[nukkit.jar:?]
        at cn.nukkit.Player.handleDataPacket(Player.java:2194) ~[nukkit.jar:?]
        at java.util.ArrayList.forEach(ArrayList.java:1257) ~[?:1.8.0_181]
        at cn.nukkit.network.Network.processPackets(Network.java:179) ~[nukkit.jar:?]
        at cn.nukkit.network.Network.processBatch(Network.java:161) [nukkit.jar:?]
        at cn.nukkit.Player.handleDataPacket(Player.java:2067) [nukkit.jar:?]
        at cn.nukkit.network.RakNetInterface.handleEncapsulated(RakNetInterface.java:157) [nukkit.jar:?]
        at cn.nukkit.raknet.server.ServerHandler.handlePacket(ServerHandler.java:132) [nukkit.jar:?]
        at cn.nukkit.network.RakNetInterface.process(RakNetInterface.java:68) [nukkit.jar:?]
        at cn.nukkit.network.Network.processInterfaces(Network.java:76) [nukkit.jar:?]
        at cn.nukkit.Server.tick(Server.java:1105) [nukkit.jar:?]
        at cn.nukkit.Server.tickProcessor(Server.java:885) [nukkit.jar:?]
        at cn.nukkit.Server.start(Server.java:862) [nukkit.jar:?]
        at cn.nukkit.Server.<init>(Server.java:553) [nukkit.jar:?]
        at cn.nukkit.Nukkit.main(Nukkit.java:95) [nukkit.jar:?]
Caused by: java.lang.RuntimeException: java.nio.channels.ClosedChannelException
        at com.google.common.base.Throwables.propagate(Throwables.java:240) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.Table.openBlock(Table.java:81) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextBlock(TableIterator.java:102) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextElement(TableIterator.java:79) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.InternalTableIterator.getNextElement(InternalTableIterator.java:51) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.resetPriorityQueue(Level0Iterator.java:88) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.<init>(Level0Iterator.java:54) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.VersionSet.makeInputIterator(VersionSet.java:209) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.doCompactionWork(DbImpl.java:947) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCompaction(DbImpl.java:430) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCall(DbImpl.java:383) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.access$100(DbImpl.java:57) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:355) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:350) ~[nukkit.jar:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_181]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_181]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_181]
        at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_181]
Caused by: java.nio.channels.ClosedChannelException
        at sun.nio.ch.FileChannelImpl.ensureOpen(FileChannelImpl.java:110) ~[?:1.8.0_181]
        at sun.nio.ch.FileChannelImpl.read(FileChannelImpl.java:721) ~[?:1.8.0_181]
        at org.iq80.leveldb.table.FileChannelTable.read(FileChannelTable.java:114) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.FileChannelTable.readBlock(FileChannelTable.java:57) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.Table.openBlock(Table.java:78) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextBlock(TableIterator.java:102) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextElement(TableIterator.java:79) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.InternalTableIterator.getNextElement(InternalTableIterator.java:51) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.resetPriorityQueue(Level0Iterator.java:88) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.<init>(Level0Iterator.java:54) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.VersionSet.makeInputIterator(VersionSet.java:209) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.doCompactionWork(DbImpl.java:947) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCompaction(DbImpl.java:430) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCall(DbImpl.java:383) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.access$100(DbImpl.java:57) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:355) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:350) ~[nukkit.jar:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_181]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) ~[?:1.8.0_181]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) ~[?:1.8.0_181]
        at java.lang.Thread.run(Thread.java:748) ~[?:1.8.0_181]
2019-03-20 19:38:40.968 [main] INFO  - §bTimNolte§f[/10.1.11.28:44661] logged out due to timeout
SupremeMortal commented 5 years ago

Could you try the latest build?

tyvioto commented 5 years ago

Hi , 314Build = Same result

You want send me Players data for Debugging this problem ? player.zip

I try connect with Nickname TYVioto

SupremeMortal commented 5 years ago

So when you cleared the players directory, it didn't occur again?

timnolte commented 5 years ago

Yeah, still dies for me. Trace looks different I think though.

2019-03-21 06:49:41.357 [main] INFO  - Loading §anukkit.yml§f ...
2019-03-21 06:49:41.821 [main] INFO  - Loading §aserver properties§f ...
2019-03-21 06:49:41.896 [main] INFO  - Selected English (eng) as the base language
2019-03-21 06:49:41.898 [main] INFO  - Starting Minecraft: PE server version §bv1.10.0§f
2019-03-21 06:49:41.925 [main] INFO  - Selected Zlib Provider: 2 (cn.nukkit.utils.ZlibThreadLocal)
2019-03-21 06:49:42.145 [main] INFO  - Opening server on 0.0.0.0:19132
2019-03-21 06:49:42.243 [main] INFO  - This server is running Nukkit version §egit-8fb2a56§f "§b§f" (API 1.0.8)
2019-03-21 06:49:42.245 [main] INFO  - Nukkit is distributed under the LGPL License
2019-03-21 06:49:47.808 [main] INFO  - Loading recipes...
2019-03-21 06:49:48.878 [main] INFO  - Loaded 954 recipes.
2019-03-21 06:49:48.885 [main] INFO  - Successfully loaded 0 resource packs
2019-03-21 06:49:49.210 [main] INFO  - Preparing level "§aNolte Minecraft World§f"
2019-03-21 06:49:49.479 [main] INFO  - Preparing level "§anether§f"
2019-03-21 06:49:49.518 [RakNet Thread #17] INFO  - Epoll is unavailable. Reverting to NioEventLoop.
2019-03-21 06:49:49.917 [main] INFO  - Starting GS4 status listener
2019-03-21 06:49:49.920 [main] INFO  - Setting query port to 19132
2019-03-21 06:49:49.923 [main] INFO  - Query is running on 0.0.0.0:19132
2019-03-21 06:49:49.926 [main] INFO  - Default game type: Survival Mode
2019-03-21 06:49:49.928 [main] INFO  - Done (8.781s)! For help, type "help" or "?"
2019-03-21 07:03:21.918 [main] ERROR - Throwing
org.iq80.leveldb.impl.DbImpl$BackgroundProcessingException: com.google.common.util.concurrent.UncheckedExecutionException: java.lang.RuntimeException: java.nio.channels.ClosedChannelException
        at org.iq80.leveldb.impl.DbImpl.checkBackgroundException(DbImpl.java:369) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.writeInternal(DbImpl.java:627) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.put(DbImpl.java:598) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.put(DbImpl.java:592) ~[nukkit.jar:?]
        at cn.nukkit.Server.updateName(Server.java:1523) ~[nukkit.jar:?]
        at cn.nukkit.Player.processLogin(Player.java:1899) ~[nukkit.jar:?]
        at cn.nukkit.Player.handleDataPacket(Player.java:2194) ~[nukkit.jar:?]
        at java.util.ArrayList.forEach(ArrayList.java:1378) ~[?:?]
        at cn.nukkit.network.Network.processPackets(Network.java:179) ~[nukkit.jar:?]
        at cn.nukkit.network.Network.processBatch(Network.java:161) [nukkit.jar:?]
        at cn.nukkit.Player.handleDataPacket(Player.java:2067) [nukkit.jar:?]
        at cn.nukkit.network.RakNetInterface.handleEncapsulated(RakNetInterface.java:157) [nukkit.jar:?]
        at cn.nukkit.raknet.server.ServerHandler.handlePacket(ServerHandler.java:132) [nukkit.jar:?]
        at cn.nukkit.network.RakNetInterface.process(RakNetInterface.java:68) [nukkit.jar:?]
        at cn.nukkit.network.Network.processInterfaces(Network.java:76) [nukkit.jar:?]
        at cn.nukkit.Server.tick(Server.java:1105) [nukkit.jar:?]
        at cn.nukkit.Server.tickProcessor(Server.java:885) [nukkit.jar:?]
        at cn.nukkit.Server.start(Server.java:862) [nukkit.jar:?]
        at cn.nukkit.Server.<init>(Server.java:553) [nukkit.jar:?]
        at cn.nukkit.Nukkit.main(Nukkit.java:95) [nukkit.jar:?]
Caused by: com.google.common.util.concurrent.UncheckedExecutionException: java.lang.RuntimeException: java.nio.channels.ClosedChannelException
        at com.google.common.cache.LocalCache$Segment.get(LocalCache.java:2217) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache.get(LocalCache.java:4154) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache.getOrLoad(LocalCache.java:4158) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$LocalLoadingCache.get(LocalCache.java:5147) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.Table.openBlock(Table.java:100) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextBlock(TableIterator.java:102) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextElement(TableIterator.java:79) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.InternalTableIterator.getNextElement(InternalTableIterator.java:51) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.resetPriorityQueue(Level0Iterator.java:88) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.<init>(Level0Iterator.java:54) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.VersionSet.makeInputIterator(VersionSet.java:209) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.doCompactionWork(DbImpl.java:951) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCompaction(DbImpl.java:430) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCall(DbImpl.java:383) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.access$100(DbImpl.java:57) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:355) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:350) ~[nukkit.jar:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) ~[?:?]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) ~[?:?]
        at java.lang.Thread.run(Thread.java:844) ~[?:?]
Caused by: java.lang.RuntimeException: java.nio.channels.ClosedChannelException
        at com.google.common.base.Throwables.propagate(Throwables.java:240) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.Table$1.load(Table.java:61) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.Table$1.load(Table.java:52) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$LoadingValueReference.loadFuture(LocalCache.java:3716) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$Segment.loadSync(LocalCache.java:2424) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$Segment.lockedGetOrLoad(LocalCache.java:2298) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$Segment.get(LocalCache.java:2211) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache.get(LocalCache.java:4154) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache.getOrLoad(LocalCache.java:4158) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$LocalLoadingCache.get(LocalCache.java:5147) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.Table.openBlock(Table.java:100) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextBlock(TableIterator.java:102) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextElement(TableIterator.java:79) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.InternalTableIterator.getNextElement(InternalTableIterator.java:51) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.resetPriorityQueue(Level0Iterator.java:88) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.<init>(Level0Iterator.java:54) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.VersionSet.makeInputIterator(VersionSet.java:209) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.doCompactionWork(DbImpl.java:951) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCompaction(DbImpl.java:430) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCall(DbImpl.java:383) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.access$100(DbImpl.java:57) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:355) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:350) ~[nukkit.jar:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) ~[?:?]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) ~[?:?]
        at java.lang.Thread.run(Thread.java:844) ~[?:?]
Caused by: java.nio.channels.ClosedChannelException
        at sun.nio.ch.FileChannelImpl.ensureOpen(FileChannelImpl.java:110) ~[?:?]
        at sun.nio.ch.FileChannelImpl.read(FileChannelImpl.java:728) ~[?:?]
        at org.iq80.leveldb.table.FileChannelTable.read(FileChannelTable.java:114) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.FileChannelTable.readBlock(FileChannelTable.java:57) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.Table$1.load(Table.java:58) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.Table$1.load(Table.java:52) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$LoadingValueReference.loadFuture(LocalCache.java:3716) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$Segment.loadSync(LocalCache.java:2424) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$Segment.lockedGetOrLoad(LocalCache.java:2298) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$Segment.get(LocalCache.java:2211) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache.get(LocalCache.java:4154) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache.getOrLoad(LocalCache.java:4158) ~[nukkit.jar:?]
        at com.google.common.cache.LocalCache$LocalLoadingCache.get(LocalCache.java:5147) ~[nukkit.jar:?]
        at org.iq80.leveldb.table.Table.openBlock(Table.java:100) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextBlock(TableIterator.java:102) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.TableIterator.getNextElement(TableIterator.java:79) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.InternalTableIterator.getNextElement(InternalTableIterator.java:51) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.AbstractSeekingIterator.hasNext(AbstractSeekingIterator.java:48) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.resetPriorityQueue(Level0Iterator.java:88) ~[nukkit.jar:?]
        at org.iq80.leveldb.util.Level0Iterator.<init>(Level0Iterator.java:54) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.VersionSet.makeInputIterator(VersionSet.java:209) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.doCompactionWork(DbImpl.java:951) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCompaction(DbImpl.java:430) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.backgroundCall(DbImpl.java:383) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl.access$100(DbImpl.java:57) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:355) ~[nukkit.jar:?]
        at org.iq80.leveldb.impl.DbImpl$2.call(DbImpl.java:350) ~[nukkit.jar:?]
        at java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167) ~[?:?]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641) ~[?:?]
        at java.lang.Thread.run(Thread.java:844) ~[?:?]
2019-03-21 07:04:49.650 [main] INFO  - §bTimNolte§f[/10.1.11.28:47849] logged out due to client disconnect
tyvioto commented 5 years ago

After Clean Players data and reboot Nukkit ,i Dont have any problem with connect.

Problem is somewhere in Players data compatibility.

timnolte commented 5 years ago

So is clearing the player data the recommended solution. I know little about Minecraft servers, as I'm just getting into it for the sake of my kids. My suspicion is that blowing away the player data means everything gathered/spawn point/etc will be gone and it will be like the player is never been on the server before?

tyvioto commented 5 years ago

Yes when you remove Plyers dala lose, al items from inventory all experiens and spawn points.

In Me opinion this is not recommended solution, from me side is only identification of problem.

SupremeMortal commented 5 years ago

Could you try adding -Dleveldb.mmap=true to your startup parameters? Before -jar

tyvioto commented 5 years ago

Hi with this java parameter, i can connect without problem and all users data are loaded. I have currently version 315. Thanks for help.

SupremeMortal commented 5 years ago

Ok, now I know what the problem is. Thanks for helping out.

tyvioto commented 5 years ago

I thanks too. With best regards. R.

SupremeMortal commented 5 years ago

5e329a6ca3028eac01ee71b7a4eee7ed0dbbf9d5 enables this by default until I find a fix.