mojira.dev
MC-149200

Crash: "Watching Server" - java.lang.Error

Resolved
Duplicate
0

The attached crash occured in 1.14 with 10 players online.
I cannot really pin down a cause, but this is the last thing the log reported:

1.14\: [^crash-2019-04-23_18.36.42-server.txt]

---- Minecraft Crash Report ----
// Everything's going to plan. No, really, that was supposed to happen.

Time: 4/23/19 6:36 PM
Description: Watching Server

java.lang.Error
	at sun.misc.Unsafe.park(Native Method)
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
	at agh.c(SourceFile:125)
	at ve.b(SourceFile:114)
	at ve.a(SourceFile:100)
	at bhh.a(SourceFile:195)
	at bhk.a(SourceFile:100)
	at bhh.c(SourceFile:190)
	at bhh.e_(SourceFile:412)
	at bml.b(SourceFile:198)
	at bxj.A(SourceFile:718)
	at us.a(SourceFile:553)
	at us$$Lambda$2347/262100474.apply(Unknown Source)
	at com.mojang.datafixers.util.Either$Left.map(Either.java:38)
	at com.mojang.datafixers.util.Either.flatMap(Either.java:191)
	at us.a(SourceFile:551)
	at us$$Lambda$2089/68973626.apply(Unknown Source)
	at java.util.concurrent.CompletableFuture.uniApply(CompletableFuture.java:602)
	at java.util.concurrent.CompletableFuture$UniApply.tryFire(CompletableFuture.java:577)
	at java.util.concurrent.CompletableFuture$Completion.run(CompletableFuture.java:442)
	at uu.b(SourceFile:57)
	at uu$$Lambda$2133/811020170.run(Unknown Source)
	at agk.e(SourceFile:83)
	at agk.a(SourceFile:123)
	at agk.run(SourceFile:91)
	at agh.h(SourceFile:135)
	at agh.p(SourceFile:114)
	at ve$a.p(SourceFile:438)
	at ve.d(SourceFile:194)
	at net.minecraft.server.MinecraftServer.aW(SourceFile:708)
	at net.minecraft.server.MinecraftServer.p(SourceFile:696)
	at agh.bf(SourceFile:99)
	at net.minecraft.server.MinecraftServer.o(SourceFile:680)
	at net.minecraft.server.MinecraftServer.run(SourceFile:636)
	at java.lang.Thread.run(Thread.java:745)


A detailed walkthrough of the error, its code path and all known details is as follows:
---------------------------------------------------------------------------------------

-- Head --
Thread: Server Watchdog
Stacktrace:
	at sun.misc.Unsafe.park(Native Method)
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
	at agh.c(SourceFile:125)
	at ve.b(SourceFile:114)
	at ve.a(SourceFile:100)
	at bhh.a(SourceFile:195)
	at bhk.a(SourceFile:100)
	at bhh.c(SourceFile:190)
	at bhh.e_(SourceFile:412)
	at bml.b(SourceFile:198)
	at bxj.A(SourceFile:718)
	at us.a(SourceFile:553)
	at us$$Lambda$2347/262100474.apply(Unknown Source)
	at com.mojang.datafixers.util.Either$Left.map(Either.java:38)
	at com.mojang.datafixers.util.Either.flatMap(Either.java:191)
	at us.a(SourceFile:551)
	at us$$Lambda$2089/68973626.apply(Unknown Source)
	at java.util.concurrent.CompletableFuture.uniApply(CompletableFuture.java:602)
	at java.util.concurrent.CompletableFuture$UniApply.tryFire(CompletableFuture.java:577)
	at java.util.concurrent.CompletableFuture$Completion.run(CompletableFuture.java:442)
	at uu.b(SourceFile:57)
	at uu$$Lambda$2133/811020170.run(Unknown Source)
	at agk.e(SourceFile:83)
	at agk.a(SourceFile:123)
	at agk.run(SourceFile:91)
	at agh.h(SourceFile:135)
	at agh.p(SourceFile:114)
	at ve$a.p(SourceFile:438)
	at ve.d(SourceFile:194)
	at net.minecraft.server.MinecraftServer.aW(SourceFile:708)
	at net.minecraft.server.MinecraftServer.p(SourceFile:696)
	at agh.bf(SourceFile:99)
	at net.minecraft.server.MinecraftServer.o(SourceFile:680)

-- Thread Dump --
Details:
	Threads: "Keep-Alive-Timer" Id=108 TIMED_WAITING
	at java.lang.Thread.sleep(Native Method)
	at sun.net.www.http.KeepAliveCache.run(KeepAliveCache.java:172)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #15" Id=57 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #14" Id=56 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #13" Id=55 RUNNABLE
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #12" Id=54 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #11" Id=53 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #10" Id=49 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #9" Id=48 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #8" Id=44 RUNNABLE
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #7" Id=43 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Java2D Disposer" Id=41 WAITING on java.lang.ref.ReferenceQueue$Lock@1df1fec0
	at java.lang.Object.wait(Native Method)
	-  waiting on java.lang.ref.ReferenceQueue$Lock@1df1fec0
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:164)
	at sun.java2d.Disposer.run(Disposer.java:148)
	at java.lang.Thread.run(Thread.java:745)


"Server Watchdog" Id=40 RUNNABLE
	at sun.management.ThreadImpl.dumpThreads0(Native Method)
	at sun.management.ThreadImpl.dumpAllThreads(ThreadImpl.java:454)
	at uj.run(SourceFile:45)
	at java.lang.Thread.run(Thread.java:745)


"RCON Listener #2" Id=39 RUNNABLE (in native)
	at java.net.PlainSocketImpl.socketAccept(Native Method)
	at java.net.AbstractPlainSocketImpl.accept(AbstractPlainSocketImpl.java:409)
	at java.net.ServerSocket.implAccept(ServerSocket.java:545)
	at java.net.ServerSocket.accept(ServerSocket.java:513)
	at yh.run(SourceFile:58)
	at java.lang.Thread.run(Thread.java:745)


"Query Listener #1" Id=38 RUNNABLE
	at java.net.PlainDatagramSocketImpl.receive0(Native Method)
	-  locked java.net.PlainDatagramSocketImpl@1336030e
	at java.net.AbstractPlainDatagramSocketImpl.receive(AbstractPlainDatagramSocketImpl.java:143)
	-  locked java.net.PlainDatagramSocketImpl@1336030e
	at java.net.DatagramSocket.receive(DatagramSocket.java:812)
	-  locked java.net.DatagramPacket@170995b0
	-  locked java.net.DatagramSocket@5d8cf55a
	at yf.run(SourceFile:260)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #6" Id=37 RUNNABLE
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #5" Id=36 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #4" Id=32 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #3" Id=31 RUNNABLE
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #2" Id=30 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #1" Id=29 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"Resource IO {0}" Id=28 WAITING on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@520b0935
	at sun.misc.Unsafe.park(Native Method)
	-  waiting on java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@520b0935
	at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
	at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
	at java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
	at java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
	at java.lang.Thread.run(Thread.java:745)


"Netty Epoll Server IO #0" Id=27 RUNNABLE (in native)
	at io.netty.channel.epoll.Native.epollWait0(Native Method)
	at io.netty.channel.epoll.Native.epollWait(Native.java:114)
	at io.netty.channel.epoll.EpollEventLoop.epollWait(EpollEventLoop.java:239)
	at io.netty.channel.epoll.EpollEventLoop.run(EpollEventLoop.java:256)
	at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:884)
	at java.lang.Thread.run(Thread.java:745)


"ObjectCleanerThread" Id=26 TIMED_WAITING on java.lang.ref.ReferenceQueue$Lock@409eea4a
	at java.lang.Object.wait(Native Method)
	-  waiting on java.lang.ref.ReferenceQueue$Lock@409eea4a
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143)
	at io.netty.util.internal.ObjectCleaner$1.run(ObjectCleaner.java:54)
	at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
	at java.lang.Thread.run(Thread.java:745)


"DestroyJavaVM" Id=24 RUNNABLE


"Server thread" Id=21 TIMED_WAITING on java.lang.String@6393bf24
	at sun.misc.Unsafe.park(Native Method)
	-  waiting on java.lang.String@6393bf24
	at java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
	at agh.c(SourceFile:125)
	at ve.b(SourceFile:114)
	at ve.a(SourceFile:100)
	at bhh.a(SourceFile:195)
	at bhk.a(SourceFile:100)
	at bhh.c(SourceFile:190)
	...


"Server Infinisleeper" Id=22 TIMED_WAITING
	at java.lang.Thread.sleep(Native Method)
	at ug$1.run(SourceFile:93)


"Snooper Timer" Id=20 WAITING on java.util.TaskQueue@38ec02f3
	at java.lang.Object.wait(Native Method)
	-  waiting on java.util.TaskQueue@38ec02f3
	at java.lang.Object.wait(Object.java:502)
	at java.util.TimerThread.mainLoop(Timer.java:526)
	at java.util.TimerThread.run(Timer.java:505)


"Signal Dispatcher" Id=4 RUNNABLE


"Finalizer" Id=3 WAITING on java.lang.ref.ReferenceQueue$Lock@3224f67a
	at java.lang.Object.wait(Native Method)
	-  waiting on java.lang.ref.ReferenceQueue$Lock@3224f67a
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143)
	at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:164)
	at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:209)


"Reference Handler" Id=2 WAITING on java.lang.ref.Reference$Lock@55f86ce
	at java.lang.Object.wait(Native Method)
	-  waiting on java.lang.ref.Reference$Lock@55f86ce
	at java.lang.Object.wait(Object.java:502)
	at java.lang.ref.Reference.tryHandlePending(Reference.java:191)
	at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153)



Stacktrace:
	at uj.run(SourceFile:61)
	at java.lang.Thread.run(Thread.java:745)

-- System Details --
Details:
	Minecraft Version: 1.14
	Operating System: Linux (amd64) version 4.15.18-12-pve
	Java Version: 1.8.0_112, Oracle Corporation
	Java VM Version: Java HotSpot(TM) 64-Bit Server VM (mixed mode), Oracle Corporation
	Memory: 2621915512 bytes (2500 MB) / 4712824832 bytes (4494 MB) up to 7635730432 bytes (7282 MB)
	JVM Flags: 1 total; -Xmx8192M
	Player Count: 9 / 64; [vh['TyniteQuiverYT'/106, l='world', x=-202.77, y=66.00, z=190.77], vh['David3112'/869, l='world', x=-11152.19, y=274.74, z=9538.99], vh['Digit1704'/957, l='world', x=-366.50, y=64.69, z=613.50], vh['NinthRex5335'/4960, l='world', x=-199.03, y=66.00, z=187.97], vh['SivanEnnair'/14571, l='world', x=-356.03, y=69.00, z=612.51], vh['pdinklag'/39907, l='world', x=1529.30, y=69.00, z=359.44], vh['Darkbastio'/43827, l='world', x=-1533.55, y=78.00, z=517.51], vh['Gorberus1336'/78758, l='world', x=-196.41, y=66.00, z=189.96], vh['Danielle2605'/97321, l='world', x=999944.61, y=68.00, z=999982.59]]
	Data Packs: vanilla, file/dvg (incompatible)
	Is Modded: Unknown (can't tell)
	Type: Dedicated Server (map_server.txt)

Linked issues

duplicates 1

Attachments

crash-2019-04-23_18.36.42-server.txt
debug-report-2021-03-31_21.35.35.zip
profile-results-2021-03-31_21.34.46.txt

Comments 5

This crash is not an issue by itself. It's just a fail safe mechanism known as watchdog which will properly crash the game if the tick exceeds a max tick time, which is 60 seconds by default. To solve this, either identify the cause of the lag, and try to report it if it applies, or increase the max tick time in server settings.

Patrick Dinklage

OK, thanks for that hint!
The server was probably busy generating all loads of chunks because we were in a new world with 10 people roaming around. Not sure if it should take 60 seconds to tick though - increasing the tick time won't exactly "improve the experience"... however, there is nothing suspicious in the logs except for the occasional "server is behind" messages.

Anyway, the crash log should definitely mention exactly what you said, that would help.

You could trigger this by running the integrated profiler:

/debug start / stop

Will output what is taking too long in server's console, and will produce a report in the debug folder after it's stopped.

Duplicate of MC-138550

This isn't resolved! I have a minehut server and it is getting this "Watching Server" crash!!! 😞

This is triggered by me 'JOINING THE SERVER!'

Patrick Dinklage

(Unassigned)

Unconfirmed

Crash

Minecraft 1.14

Retrieved