Console spammed with "Failed to read packet from..." messages

Question

Console spammed with "Failed to read packet from..." messages

Blayung opened this issue 2 years ago · 1 comments

Blayung commented 2 years ago

Please read the wiki before submitting a bug report!

Bug description
Basically, the plugin is spamming with such warnings:
[21:37:00 WARN]: [voicechat] Failed to read packet from /69.213.7.420:666
or (idk why is it different, maybe it's because of an older version of the plugin in my old logs)
[21:37:00] [VoiceChatPacketProcessingThread/WARN]: [voicechat] Failed to read packet from /51.15.244.103:49701
I saw this error described before, but everyone said, that it was some problem with the host, but didn't say what problem is it. I'm hosting my server on my own in my house, and I don't know what to do. When I had my server running idle and no one joining for like a month or so, the console was full of these messages.

Steps to reproduce the issue

Install simple voice chat plugin
Enjoy! (or not)

Expected behavior
The plugin doesn't spam with warnings.

Log files
Please provide log files of the game session in which the problem occurred.
Don't paste the complete logs into the issue.
You can use https://gist.github.com/.

There is an example starting log (later it continues to spam with warnings no matter what):

[15:53:21] [ServerMain/INFO]: Building unoptimized datafixer
[15:53:22] [ServerMain/INFO]: Environment: authHost='https://authserver.mojang.com', accountsHost='https://api.mojang.com', sessionHost='https://sessionserver.mojang.com', servicesHost='https://api.minecraftservices.com', name='PROD'
[15:53:24] [ServerMain/INFO]: Loaded 7 recipes
[15:53:25] [Server thread/INFO]: Starting minecraft server version 1.19
[15:53:25] [Server thread/INFO]: Loading properties
[15:53:25] [Server thread/INFO]: This server is running Paper version git-Paper-32 (MC: 1.19) (Implementing API version 1.19-R0.1-SNAPSHOT) (Git: 4c9317c)
[15:53:25] [Server thread/INFO]: Server Ping Player Sample Count: 12
[15:53:25] [Server thread/INFO]: Using 4 threads for Netty based IO
[15:53:25] [Server thread/INFO]: Default game type: SURVIVAL
[15:53:25] [Server thread/INFO]: Generating keypair
[15:53:25] [Server thread/INFO]: Starting Minecraft server on *:25565
[15:53:25] [Server thread/INFO]: Using epoll channel type
[15:53:25] [Server thread/INFO]: Paper: Using libdeflate (Linux x86_64) compression from Velocity.
[15:53:25] [Server thread/INFO]: Paper: Using Java cipher from Velocity.
[15:53:26] [Server thread/INFO]: [CoreProtect] Loading CoreProtect v21.2
[15:53:26] [Server thread/INFO]: [LuckPerms] Loading LuckPerms v5.4.30
[15:53:26] [Server thread/INFO]: [voicechat] Loading voicechat v1.19-2.2.52
[15:53:26] [Server thread/INFO]: [myplugin] Loading myplugin v1.0.0
[15:53:26] [Server thread/INFO]: [ProtocolLib] Loading ProtocolLib v5.0.0-SNAPSHOT-b577
[15:53:27] [Server thread/INFO]: [AuthMe] Loading AuthMe v5.6.0-SNAPSHOT-bCUSTOM
[15:53:27] [Server thread/INFO]: [SkinsRestorer] Loading SkinsRestorer v14.2.3
[15:53:27] [Server thread/INFO]: [SuperVanish] Loading SuperVanish v6.2.12
[15:53:27] [Server thread/INFO]: Server permissions file permissions.yml is empty, ignoring it
[15:53:27] [Server thread/INFO]: [LuckPerms] Enabling LuckPerms v5.4.30
[15:53:27] [Server thread/INFO]:         __    
[15:53:27] [Server thread/INFO]:   |    |__)   LuckPerms v5.4.30
[15:53:27] [Server thread/INFO]:   |___ |      Running on Bukkit - Paper
[15:53:27] [Server thread/INFO]: 
[15:53:27] [Server thread/INFO]: [LuckPerms] Loading configuration...
[15:53:28] [Server thread/INFO]: [LuckPerms] Loading storage provider... [H2]
[15:53:28] [Server thread/INFO]: [LuckPerms] Loading internal permission managers...
[15:53:28] [Server thread/INFO]: [LuckPerms] Performing initial data load...
[15:53:28] [Server thread/INFO]: [LuckPerms] Successfully enabled. (took 1137ms)
[15:53:28] [Server thread/INFO]: [ProtocolLib] Enabling ProtocolLib v5.0.0-SNAPSHOT-b577
[15:53:28] [Server thread/INFO]: [ProtocolLib] Started structure compiler thread.
[15:53:28] [Server thread/WARN]: **** SERVER IS RUNNING IN OFFLINE/INSECURE MODE!
[15:53:28] [Server thread/WARN]: The server will make no attempt to authenticate usernames. Beware.
[15:53:28] [Server thread/WARN]: While this makes the game possible to play without internet access, it also opens up the ability for hackers to connect with any username they choose.
[15:53:28] [Server thread/WARN]: To change this, set "online-mode" to "true" in the server.properties file.
[15:53:28] [Server thread/INFO]: Preparing level "world"
[15:54:03] [Server thread/INFO]: Preparing start region for dimension minecraft:overworld
[15:54:03] [Server thread/INFO]: Time elapsed: 185 ms
[15:54:03] [Server thread/INFO]: Preparing start region for dimension minecraft:the_nether
[15:54:03] [Server thread/INFO]: Time elapsed: 67 ms
[15:54:03] [Server thread/INFO]: Preparing start region for dimension minecraft:the_end
[15:54:03] [Server thread/INFO]: Time elapsed: 63 ms
[15:54:03] [Server thread/INFO]: [CoreProtect] Enabling CoreProtect v21.2
[15:54:03] [Server thread/INFO]: [CoreProtect] CoreProtect has been successfully enabled! 
[15:54:03] [Server thread/INFO]: [CoreProtect] Using SQLite for data storage.
[15:54:03] [Server thread/INFO]: --------------------
[15:54:03] [Server thread/INFO]: [CoreProtect] Enjoy CoreProtect? Join our Discord!
[15:54:03] [Server thread/INFO]: [CoreProtect] Discord: www.coreprotect.net/discord/
[15:54:03] [Server thread/INFO]: --------------------
[15:54:03] [Server thread/INFO]: [voicechat] Enabling voicechat v1.19-2.2.52
[15:54:03] [Server thread/INFO]: [voicechat] Compatibility version 14
[15:54:03] [Server thread/INFO]: [voicechat] Loading translations
[15:54:03] [Server thread/INFO]: [voicechat] Successfully initialized commodore command completion
[15:54:03] [Server thread/INFO]: [myplugin] Enabling myplugin v1.0.0
[15:54:03] [Server thread/INFO]: [AuthMe] Enabling AuthMe v5.6.0-SNAPSHOT-bCUSTOM
[15:54:03] [Server thread/INFO]: [AuthMe] SQLite Setup finished
[15:54:03] [Server thread/INFO]: [AuthMe] Hooked into LuckPerms!
[15:54:04] [Server thread/INFO]: [AuthMe] AuthMe 5.6.0-SNAPSHOT build n.CUSTOM successfully enabled!
[15:54:04] [Server thread/INFO]: [SkinsRestorer] Enabling SkinsRestorer v14.2.3
[15:54:04] [Server thread/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1mDetected Minecraft �[33;1mv1_19_R1�[32;1m, using �[33;1mPaperSkinRefresher�[32;1m.�[0;39m
[15:54:04] [Server thread/INFO]: [SkinsRestorer] [ACF] Enabled Asynchronous Tab Completion Support!
[15:54:04] [Server thread/INFO]: [SuperVanish] Enabling SuperVanish v6.2.12
[15:54:04] [Server thread/INFO]: Running delayed init tasks
[15:54:04] [Craft Scheduler Thread - 5 - AuthMe/INFO]: [AuthMe] Downloading GEO IP database, because the old database is older than 30 days or doesn't exist
[15:54:04] [Craft Scheduler Thread - 5 - AuthMe/WARN]: [AuthMe] No MaxMind credentials found in the configuration file! GeoIp protections will be disabled.
[15:54:04] [Craft Scheduler Thread - 5 - AuthMe/INFO]: [AuthMe] There is no newer GEO IP database uploaded to MaxMind. Using the old one for now.
[15:54:04] [Craft Scheduler Thread - 5 - AuthMe/WARN]: [AuthMe] Could not download GeoLiteAPI database [FileNotFoundException]: plugins/AuthMe/GeoLite2-Country.mmdb (No such file or directory)
[15:54:04] [Server thread/INFO]: [voicechat] Loading plugins
[15:54:04] [Server thread/INFO]: [voicechat] Loaded 0 plugin(s)
[15:54:04] [Server thread/INFO]: [voicechat] Initializing plugins
[15:54:04] [Server thread/INFO]: [voicechat] Initialized 0 plugin(s)
[15:54:04] [Server thread/WARN]: [voicechat] Running in offline mode - Voice chat encryption is not secure!
[15:54:04] [Server thread/INFO]: [voicechat] Using default voicechat socket implementation
[15:54:04] [VoiceChatServerThread/INFO]: [voicechat] Server started at port 25565
[15:54:04] [Server thread/INFO]: Done (39.580s)! For help, type "help"
[15:54:04] [Server thread/INFO]: Timings Reset
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1m----------------------------------------------�[0;39m
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1m    +==================+�[0;39m
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1m    |   SkinsRestorer  |�[0;39m
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1m    |------------------|�[0;39m
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1m    |  �[34;1m�[4m�[21mStandalone Mode�[0;39m�[32;1m |�[0;39m
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1m    +==================+�[0;39m
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1m----------------------------------------------�[0;39m
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[36;1m    Current version: �[32;1m14.2.3�[0;39m
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1m    This is the latest version!�[0;39m
[15:54:05] [Craft Scheduler Thread - 6 - SkinsRestorer/INFO]: �[33;1m[�[32;22mSkinsRestorer�[33;1m] �[0;39m�[32;1m----------------------------------------------�[0;39m
[16:39:53] [User Authenticator #1/INFO]: UUID of player _Blay_ is b835866b-2f3c-32f2-a1ef-8effeaa7ec5d
[16:39:53] [Server thread/INFO]: _Blay_ joined the game
[16:39:53] [Server thread/INFO]: _Blay_[/192.168.1.114:53604] logged in with entity id 168 at ([world]-28.2518353695185, 71.0, -77.54709145871877)
[16:39:57] [Server thread/INFO]: [voicechat] Received secret request of _Blay_ (14)
[16:39:57] [Server thread/INFO]: [voicechat] Sent secret to _Blay_
[16:40:01] [VoiceChatPacketProcessingThread/INFO]: [voicechat] Successfully authenticated player b835866b-2f3c-32f2-a1ef-8effeaa7ec5d
[16:40:16] [Craft Scheduler Thread - 26 - AuthMe/INFO]: [AuthMe] _Blay_ logged in 192.168.1.114
[16:40:36] [Server thread/INFO]: _Blay_ lost connection: Disconnected
[16:40:36] [Server thread/INFO]: [voicechat] Disconnecting client _Blay_
[16:40:36] [Server thread/INFO]: _Blay_ left the game
[16:41:56] [VoiceChatPacketProcessingThread/WARN]: [voicechat] Failed to read packet from /51.15.244.103:37796

Versions

Minecraft version: 1.19
Forge/Fabric/Bukkit/Spigot/Paper version: git-Paper-32 (MC: 1.19) <it's the format that version_history.json provides>
Mod/Plugin version: 2.2.52

Other mods
A list of the other mods/plugins that were installed when this problem occurred.
It would be ideal if you could test if this problem persists when no other mod/plugin is installed.
If not, please narrow down the mod(s)/plugin(s) that are causing the problem.

Installed plugins:

Auth me
Super vanish
Core protect
Protocol lib
Luck perms
Skins restorer
Simple voicechat
My own plugin (just a few simple commands, so I don't think, that it causes the problem)

Screenshots (Optional)
Screenshots of the issue.

There's an example image of log when server is idle:

henkelmax · Answer 1 · 2022-09-27T17:34:10.000Z

This has already been removed in a newer version.

Share to