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

Unexpectedly disconnected from remote server #1251

Open
Teslicek opened this issue Feb 23, 2024 · 9 comments
Open

Unexpectedly disconnected from remote server #1251

Teslicek opened this issue Feb 23, 2024 · 9 comments
Labels
status: awaiting response More information is required type: bug Something isn't working

Comments

@Teslicek
Copy link

Sometimes, when a player has a weird connection, they are kicked to the fallback server without properly joining it, which causes an error on proxy, as well as some random message on the backend server.

Upon asking, I was told that this error is caused by the client being stuck in the configuration phase, because the proxy did not receive any packets from the client.

Happened on Velocity 359 with no resource pack.

Backend message:

[14:17:38 INFO]: com.mojang.authlib.GameProfile@6b42ad17[id=337fe0e8-d37d-4e5e-b2fc-583f25df3f90,name=Hachimaki950529,properties={textures=[Property[name=textures, value=ewogICJ0aW1lc3RhbXAiIDogMTcwODY4OTE5ODIyMywKICAicHJvZmlsZUlkIiA6ICIzMzdmZTBlOGQzN2Q0ZTVlYjJmYzU4M2YyNWRmM2Y5MCIsCiAgInByb2ZpbGVOYW1lIiA6ICJIYWNoaW1ha2k5NTA1MjkiLAogICJzaWduYXR1cmVSZXF1aXJlZCIgOiB0cnVlLAogICJ0ZXh0dXJlcyIgOiB7CiAgICAiU0tJTiIgOiB7CiAgICAgICJ1cmwiIDogImh0dHA6Ly90ZXh0dXJlcy5taW5lY3JhZnQubmV0L3RleHR1cmUvYWJiYzM0N2VjNTkxNzBmZDRmODlkYmUxMDg4ZGI3NGVjZDY0ZWE2N2YwNmNjZWNkNmFiODdiNzFlNjkyNTk2YiIsCiAgICAgICJtZXRhZGF0YSIgOiB7CiAgICAgICAgIm1vZGVsIiA6ICJzbGltIgogICAgICB9CiAgICB9CiAgfQp9, signature=rwgPbrDpEMXIttrj3wxvsMuXekeGb515yzqRPUSjTpWZWFBJCDOAeAJ/06MF0aJUzXHReI1oIS6INwk01O3PZxtYhGugRnWwMPPG0cQyo2hniRJvmjNzfg2eBLs5BdCGTInGtz/lhoVKD45FEPqAzLDOxpLakfxiYzYOyU5wUk28iTU89t33/sIF4MxpkO4Lf9ibFPhyJO2zoaC6T3qnI8ESZ/r1r7FhLrIxoriXeLM9PJ/4O0LIrutkwImUSPC8vzJTCRcfdlkgBtk9CLj5P1CPZlWk9M/IzsjJOy2pgOH0M6LylVNWkr+L0tvW7aRJrrgII+QOTHcBHwhTdxhRR5VkLncMwc7iPGRAi3GYPkj45aVKOBeh9ywlQAD1Db71WKoosfHP/jv14Yx67xDzrBDxiLFttzaN/mATsiT/ygwEiNy4u2x1/XA6701xNwlEMI8DQwxkWFf6dzZTYKqdbbHEsS98c8Z/b3l/ekd/eQzFLI1WPxBl7nxQMQngMbvK9pWCutmW2mojKJWGOEOYAzOc9AJ8iY8R5+7zOMAuL2VdSaloHCKBBrGE6a4fVLiOIhhMGi3kbmXzbkTPZPCIV6t5/ZpZFdumT99bCM84KHYGimyDopiE77rRBGvPNrRXEgWzJn54oj5IBquptd7P4+WsZgHHrIw3qZUcZCBrpr0=]]}] lost connection: Disconnected

Velocity error:

[14:17:08] [Netty epoll Worker #42/INFO] [com.velocitypowered.proxy.connection.MinecraftConnection]: [server connection] Hachimaki950529 -> lifesteal has disconnected
[14:17:08] [Netty epoll Worker #42/INFO] [com.velocitypowered.proxy.connection.MinecraftConnection]: [server connection] Hachimaki950529 -> hub has connected
[14:17:38] [Netty epoll Worker #42/ERROR] [com.velocitypowered.proxy.connection.MinecraftConnection]: [server connection] Hachimaki950529 -> hub: read timed out
[14:17:38] [Netty epoll Worker #42/INFO] [com.velocitypowered.proxy.connection.MinecraftConnection]: [server connection] Hachimaki950529 -> hub has disconnected
[14:17:38] [Netty epoll Worker #42/ERROR] [com.velocitypowered.proxy.connection.client.ConnectedPlayer]: [connected player] Hachimaki950529 ((their ip):45158): unable to connect to server hub
java.io.IOException: Unexpectedly disconnected from remote server
	at com.velocitypowered.proxy.connection.backend.ConfigSessionHandler.disconnected(ConfigSessionHandler.java:224) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at com.velocitypowered.proxy.connection.MinecraftConnection.channelInactive(MinecraftConnection.java:125) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.ChannelInboundHandlerAdapter.channelInactive(ChannelInboundHandlerAdapter.java:81) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at com.velocitypowered.proxy.protocol.netty.PlayPacketQueueHandler.channelInactive(PlayPacketQueueHandler.java:81) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.ChannelInboundHandlerAdapter.channelInactive(ChannelInboundHandlerAdapter.java:81) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.handler.timeout.IdleStateHandler.channelInactive(IdleStateHandler.java:277) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.handler.codec.ByteToMessageDecoder.channelInputClosed(ByteToMessageDecoder.java:411) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.handler.codec.ByteToMessageDecoder.channelInactive(ByteToMessageDecoder.java:376) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.DefaultChannelPipeline$HeadContext.channelInactive(DefaultChannelPipeline.java:1405) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:301) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.DefaultChannelPipeline.fireChannelInactive(DefaultChannelPipeline.java:901) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.AbstractChannel$AbstractUnsafe$7.run(AbstractChannel.java:813) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.util.concurrent.AbstractEventExecutor.runTask(AbstractEventExecutor.java:173) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:166) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:470) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:413) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:997) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[velocity-359-custom.jar:3.3.0-SNAPSHOT (git-ecf936f3)]
	at java.base/java.lang.Thread.run(Thread.java:840) [?:?]
[14:17:38] [Netty epoll Worker #42/INFO] [com.velocitypowered.proxy.connection.client.ConnectedPlayer]: [connected player] Hachimaki950529 ((their ip):45158) has disconnected: 无法将您连接至 hub,请稍后再试。
@4drian3d
Copy link
Contributor

You are using an old version, can you try the latest build?

@4drian3d 4drian3d added status: awaiting response More information is required unconfirmed labels Feb 23, 2024
@Teslicek
Copy link
Author

This time, the error on velocity is gone (1h40m uptime), however, the glitched backend message stays, since the user never actually joined it.

Velocity 362, no resource pack

Backend message:

[18:15:41 INFO]: com.mojang.authlib.GameProfile@49f9aa75[id=e0dcc255-4e57-4d05-9473-bea662026deb,name=Pergsola,properties={textures=[Property[name=textures, value=ewogICJ0aW1lc3RhbXAiIDogMTcwODcwODQyMTkyOSwKICAicHJvZmlsZUlkIiA6ICJlMGRjYzI1NTRlNTc0ZDA1OTQ3M2JlYTY2MjAyNmRlYiIsCiAgInByb2ZpbGVOYW1lIiA6ICJQZXJnc29sYSIsCiAgInNpZ25hdHVyZVJlcXVpcmVkIiA6IHRydWUsCiAgInRleHR1cmVzIiA6IHsKICAgICJTS0lOIiA6IHsKICAgICAgInVybCIgOiAiaHR0cDovL3RleHR1cmVzLm1pbmVjcmFmdC5uZXQvdGV4dHVyZS81ZmU1YTU0YjI0NTI5ZWZjZWFlYTljNjAwNzU1NDc5NDk2NmY1ZjVmYjY2Yjc1MTZhNTQ5Zjk0MGExOTE4MTAiCiAgICB9CiAgfQp9, signature=e8Wmt63ytWFyIcIEuAb9tssJLoPt5qUPCt4FpvcF+SOl53ZgvAqKOLaxwGup+pZGWYSC373HqbTrE8+qpbcDi7NlpDo5v4ODMNcojOLYJz+iZdyI7iPVqAKwBC+G7oe1MaWRNAc8I+c/vEPFWwu7o/Du9JxXeh0Tvz0OLFZl4DlLU57Y5sLH+/lR45JE1vnqZ25+Q4NS8rFqAOgy3YT9wmnEBl68wQLl4zwgAtu4ctJG6vJPed9YWuHfaLDzFMpI6bxueXzWAxIKcdEKBUe4AA6smJgt7Di0zZsPceloxWxpGmxq0mfkrkB5/NOlM2bIxfQ04TURT9iSuBcqxvP0riaHjZqBLiAzwjgSbX1TikeCdu+Wn/AKJq0U2OU2Wq+qZL46ZZxsFJqP9I/SpgFiaK4HqStKA3BO7avI7usy6RkCaGSlElYvpzyF9021fZnD5XZmXJIn93koeofZo7Jn5NjbytSyoeqrCpenMp6PrfMcTXYesRUwmtHnyIhv/Fw7ZH6tRm2eOLHx+vEZiyGDuCjLZnTzWjUysjoYFxalCoeelegpfUVPwh+7T9Rt2v/1fjPdFTo9CpWJ0rM+7xTs/BooTc0Ir3Yi65Dm6eqMT8cqcamjbpLGZLZi9USSEKvzsKIdG9r4fpE7ITvzpLwH5vua+7brKpYFLja18UXyZNM=]]}] lost connection: Disconnected

Velocity logs:

[18:15:34] [Netty epoll Worker #34/INFO] [com.velocitypowered.proxy.connection.client.ConnectedPlayer]: [connected player] Pergsola (dextersouth03.d.subnet.rcn.com/(their ip):57450): kicked from server lifesteal: 
[18:15:34] [Netty epoll Worker #34/INFO] [com.velocitypowered.proxy.connection.MinecraftConnection]: [server connection] Pergsola -> lifesteal has disconnected
[18:15:34] [Netty epoll Worker #34/INFO] [com.velocitypowered.proxy.connection.MinecraftConnection]: [server connection] Pergsola -> hub has connected
[18:15:40] [Netty epoll Worker #34/INFO] [com.velocitypowered.proxy.connection.MinecraftConnection]: [connected player] Pergsola (dextersouth03.d.subnet.rcn.com/(their ip):57450) has disconnected
[18:15:40] [Netty epoll Worker #34/INFO] [com.velocitypowered.proxy.connection.MinecraftConnection]: [server connection] Pergsola -> hub has disconnected

@Teslicek
Copy link
Author

Update:

One dude actually managed to trigger the error even on the Velocity 362 (no resource pack).

Backend (hub) logs:

[21:12:23 INFO]: solo_mag1c[IP hidden] logged in with entity id 401 at ([world]0.5, 1.0, 0.5)
[21:12:24 INFO]: solo_mag1c lost connection: Timed out
[21:12:54 INFO]: com.mojang.authlib.GameProfile@3faeadb0[id=bb6cd613-e781-45fa-956b-2903c4d67df1,name=solo_mag1c,properties={textures=[Property[name=textures, value=ewogICJ0aW1lc3RhbXAiIDogMTcwODcxOTA3NzI2NSwKICAicHJvZmlsZUlkIiA6ICJiYjZjZDYxM2U3ODE0NWZhOTU2YjI5MDNjNGQ2N2RmMSIsCiAgInByb2ZpbGVOYW1lIiA6ICJzb2xvX21hZzFjIiwKICAic2lnbmF0dXJlUmVxdWlyZWQiIDogdHJ1ZSwKICAidGV4dHVyZXMiIDogewogICAgIlNLSU4iIDogewogICAgICAidXJsIiA6ICJodHRwOi8vdGV4dHVyZXMubWluZWNyYWZ0Lm5ldC90ZXh0dXJlLzU5YjA0OTI4MzdmNjcwMmUyNzYzYTUyYzc1ZWY5YWZiOWY4YTk3YjRhZWIzZGM2Nzg1ODc5M2VhOWVhYjQzM2UiCiAgICB9CiAgfQp9, signature=T2IdGrcTi8ct7Qjmh7don9S3HY1pfjUpxdDq5J2/HFf4ImyOMIpRB/yzm++5DrFlb+xO3GYlXLcJBzNkXcctcMtAIsmlP/E9NV1tM6lZ2GVbu5P9RgyTCF8qY+UPdnmIsC3AH4uZK0v4FQoM6dPzYc1RHGw9RoYaLJHvVHb4yZi29qSs4J9iDEUoeOsF+OhVoo2YGnS1+lq2N9VQ+RfDcZe61I56Sqzanqm25z2pKJ0YmOaMEIRI0tzVHVHuGIIg55jAVkwFp1xmEd76WZa7Il0mkJZr7phVP06fJgPkRhYGdXwHkr1lP7mgN2AQfEwtkti8rXGA7V314aB/8bwF1IoyBVbbHGhjCYV9C3nO85VX1pvVumIWJ4a9QgA+xu/CUeVpoLyQEWyUKyrRua9PmAo+fZEZiNTEt5hQuDqHEk/3ZykstNc5455QjDgQn0662OABB9Pw9jXKVxyRXIIlPO0f5BM5UKdqhrdX+hQtgAR5APoJClXgZOHR8CljDHua5x9ee7TqZVV/W6NsA6bFHdrEFq3GqDYJ+aMHKiol1tR/q0aQd4WAuuvEPkfxPVtwY7Xh6skRuZEOj4NMyfbTQ7wmhuyCcC3sVZO0/ziwNcPjRoXahzl79atnybN1oVLmOnGT6FDpEe9pARsd2dezVSqrQUQKs4jTNe2u17ddWZ4=]]}] lost connection: Disconnected

Velocity logs:

[21:12:24 INFO]: [connected player] solo_mag1c (abc:2685): kicked from server hub: 
[21:12:24 INFO]: [server connection] solo_mag1c -> hub has disconnected
[21:12:24 INFO]: [server connection] solo_mag1c -> lifesteal has connected
[21:12:54 ERROR]: [server connection] solo_mag1c -> lifesteal: read timed out
[21:12:54 INFO]: [server connection] solo_mag1c -> lifesteal has disconnected
[21:12:54 ERROR]: [connected player] solo_mag1c (abc:2685): unable to connect to server lifesteal
java.io.IOException: Unexpectedly disconnected from remote server
        at com.velocitypowered.proxy.connection.backend.ConfigSessionHandler.disconnected(ConfigSessionHandler.java:224) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at com.velocitypowered.proxy.connection.MinecraftConnection.channelInactive(MinecraftConnection.java:125) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.ChannelInboundHandlerAdapter.channelInactive(ChannelInboundHandlerAdapter.java:81) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at com.velocitypowered.proxy.protocol.netty.PlayPacketQueueHandler.channelInactive(PlayPacketQueueHandler.java:81) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.ChannelInboundHandlerAdapter.channelInactive(ChannelInboundHandlerAdapter.java:81) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.handler.timeout.IdleStateHandler.channelInactive(IdleStateHandler.java:277) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.handler.codec.ByteToMessageDecoder.channelInputClosed(ByteToMessageDecoder.java:411) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.handler.codec.ByteToMessageDecoder.channelInactive(ByteToMessageDecoder.java:376) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.DefaultChannelPipeline$HeadContext.channelInactive(DefaultChannelPipeline.java:1405) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:301) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.DefaultChannelPipeline.fireChannelInactive(DefaultChannelPipeline.java:901) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.AbstractChannel$AbstractUnsafe$7.run(AbstractChannel.java:813) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.util.concurrent.AbstractEventExecutor.runTask(AbstractEventExecutor.java:173) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:166) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:470) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:413) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:997) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[velocity-362-custom.jar:3.3.0-SNAPSHOT (git-7ca06899)]
        at java.base/java.lang.Thread.run(Thread.java:840) [?:?]
[21:12:54 INFO]: [server connection] solo_mag1c -> hub has connected
[21:12:54 INFO]: [connected player] solo_mag1c (abc:2685) has disconnected: An internal error occurred in your connection.
[21:12:54 ERROR]: [connected player] solo_mag1c (abc:2685): read timed out
[21:12:54 INFO]: [server connection] solo_mag1c -> hub has disconnected

@4drian3d 4drian3d added type: bug Something isn't working and removed status: awaiting response More information is required unconfirmed labels Feb 23, 2024
@4drian3d
Copy link
Contributor

Can you try the latest version?

@4drian3d 4drian3d added the status: awaiting response More information is required label Feb 24, 2024
@Teslicek
Copy link
Author

Unfortunately, the bug still happens even on the latest velocity version.

Backend (hub) logs:

[22:50:53 INFO]: com.mojang.authlib.GameProfile@73569fdb[id=b43bad7b-f39a-4ae1-9aa4-6494805c7fbd,name=floorboarding,properties={textures=[Property[name=textures, value=ewogICJ0aW1lc3RhbXAiIDogMTcwODgxMTEwNzE5NCwKICAicHJvZmlsZUlkIiA6ICJiNDNiYWQ3YmYzOWE0YWUxOWFhNDY0OTQ4MDVjN2ZiZCIsCiAgInByb2ZpbGVOYW1lIiA6ICJmbG9vcmJvYXJkaW5nIiwKICAic2lnbmF0dXJlUmVxdWlyZWQiIDogdHJ1ZSwKICAidGV4dHVyZXMiIDogewogICAgIlNLSU4iIDogewogICAgICAidXJsIiA6ICJodHRwOi8vdGV4dHVyZXMubWluZWNyYWZ0Lm5ldC90ZXh0dXJlLzJmZjk0ODI0MTA1YTYyMGQ1M2ZhNDAzNmUzNTRjOTIxOWE2YmJjNjkyNTFjZjFkNTZmNTBlMDFjOWNmYWEzM2QiCiAgICB9CiAgfQp9, signature=rREzzYL+IGWss5bmJozvF0YWyWQCXzgPvOURkVk2NmuBk9HQC61euzUc5o8pca/6QZgyF6vrkOAb5sE9YOUwNnXT9JPB8OuJ5d9qNR66exs2nWekLcOUE6YWWWX5CBNegZ5eD5JHpyL1uecHesjh6tKSA4KtUJOK1TluYFMqkv4PYS9um0OHJbw/FwjwN0JlkAe2uF8sRt0OXlzFCcJCpmPjexzFDYSlLfUi2ILtUaevjptomA/ns1N33C3KaeT0yXfAFvZl8wOo58IjznUNB4lnM9CtMr+ki5OjoJzKztNIN2fZzXklzEXDRNlzNWrG5pgAbaL0j1KQwCd5PT3m38y5KfQoC/7eXIkOeIN5wbP1Ezs4ScpPrKLYv4/G7h6F9gVKlErXvh0uAbkjTIOWVaHjBuWjR9am6DUQyux+CKO7qfsgyLbn9XRv5xSyXRcL4Crq0ky6g43HWQ5Oga5RiLX5Nbsr6jPGBH6uV8P88B5BL7WeLZZd4d7n5UzCNSILf4KekDt0BEmeg43xjlztFy1y8NKUqWAb1hhP6SBDt0CrpHTTiE7ALjGoHqJgcSStay8ZDJU0JxpzeUtabPA3VIYyy74jLfXQaNmFgQyiJsoKAy1LoEoE8vYEM9PwLK9r35YDL0tqm/YJwFj/weHQ6RfDfxgC24UYTjxA6lq10F0=]]}] lost connection: Disconnected

Velocity logs:

[22:50:53] [Netty epoll Worker #47/ERROR] [com.velocitypowered.proxy.connection.MinecraftConnection]: [server connection] floorboarding -> hub: read timed out
[22:50:53] [Netty epoll Worker #47/INFO] [com.velocitypowered.proxy.connection.MinecraftConnection]: [server connection] floorboarding -> hub has disconnected
[22:50:53] [Netty epoll Worker #47/ERROR] [com.velocitypowered.proxy.connection.client.ConnectedPlayer]: [connected player] floorboarding (abc:52342): unable to connect to server hub
java.io.IOException: Unexpectedly disconnected from remote server
	at com.velocitypowered.proxy.connection.backend.ConfigSessionHandler.disconnected(ConfigSessionHandler.java:224) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at com.velocitypowered.proxy.connection.MinecraftConnection.channelInactive(MinecraftConnection.java:125) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.ChannelInboundHandlerAdapter.channelInactive(ChannelInboundHandlerAdapter.java:81) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at com.velocitypowered.proxy.protocol.netty.PlayPacketQueueHandler.channelInactive(PlayPacketQueueHandler.java:81) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.ChannelInboundHandlerAdapter.channelInactive(ChannelInboundHandlerAdapter.java:81) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.handler.timeout.IdleStateHandler.channelInactive(IdleStateHandler.java:277) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.handler.codec.ByteToMessageDecoder.channelInputClosed(ByteToMessageDecoder.java:411) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.handler.codec.ByteToMessageDecoder.channelInactive(ByteToMessageDecoder.java:376) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:303) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.fireChannelInactive(AbstractChannelHandlerContext.java:274) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.DefaultChannelPipeline$HeadContext.channelInactive(DefaultChannelPipeline.java:1405) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:301) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelInactive(AbstractChannelHandlerContext.java:281) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.DefaultChannelPipeline.fireChannelInactive(DefaultChannelPipeline.java:901) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.AbstractChannel$AbstractUnsafe$7.run(AbstractChannel.java:813) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.util.concurrent.AbstractEventExecutor.runTask(AbstractEventExecutor.java:173) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:166) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:470) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:413) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.util.concurrent.SingleThreadEventExecutor$4.run(SingleThreadEventExecutor.java:997) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) ~[velocity-363-custom.jar:3.3.0-SNAPSHOT (git-74c932e5)]
	at java.base/java.lang.Thread.run(Thread.java:840) [?:?]
[22:50:53] [Netty epoll Worker #47/INFO] [com.velocitypowered.proxy.connection.client.ConnectedPlayer]: [connected player] floorboarding (abc:52342) has disconnected: Unable to connect you to hub. Please try again later.

@chasertw123
Copy link

Unknown if this related but when I try and join a server while already having been on a server before I now get a "An internal error occurred in your connection." This happening during the Config Phase as I never see the server before disconnected and am in the dirt screen for awhile.

There are no errors in the logs.
I am on latest: Velocity 3.3.0-SNAPSHOT (git-74c932e5-b363)

@AoElite
Copy link
Contributor

AoElite commented Mar 20, 2024

@4drian3d This issue is still present in latest velocity.

@R00tB33rMan
Copy link
Contributor

Still persists in 8f4adb1.

@UserTeemu
Copy link

I have ran build 358 (the build before 359 which in the original post was said to have this issue) for a few months. During that, I never saw this issue.
However, yesterday I upgraded to build 385, after which I started having this issue with random disconnects.
Based on this information, I would suspect this has something to do with commit ecf936f which was the only change between build 358 and 359.
There could also be other changes (mods) that could have influenced this yesterday, so please do not consider this a scientific experiment.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
status: awaiting response More information is required type: bug Something isn't working
Projects
None yet
Development

No branches or pull requests

6 participants