Roon becomes unresponsive intermittently during startup since build 1455 (ref#AXKMI9)

Burkhardt_Petermann · August 22, 2024, 8:05am

Is Roon Server running?

· Yes, Roon Server is turned on and running.

What do you see on your screen?

· I see something else

When you try to connect, what screen do you see?

· Just the Roon logo

Please try to restart your Roon Server by closing the Roon app in the taskbar or rebooting your Roon Server machine.

· No, the issue remains the same

Please try to restart your network setup by unplugging, waiting 30 seconds and then replugging in your networking gear.

· No, the issue remains the same

Please select how you've connected your Roon Server to the internet

· Roon Server is connected by *Ethernet*

Have you checked your firewall settings to ensure that Roon is allowed through?

· Roon still won't connect even after checking this aspect

Have you verified that Roon Server is on the same subnet as your Remotes?

· My Remotes and Server are on the same subnet and I still can't connect

Sometimes the issues can be resolved with a reinstall of your Roon Remote app. Let's try to perform a reinstall and see if it helps.

· I've reinstalled the Roon Remote but it did not help

What is the operating system of your Roon Server host machine?

· *Linux Server* (Ubuntu, Fedora, ArcLinux...)

Select any of the following components that are present in your local network setup

· None of the above

Describe the issue

Roon not responsing every few minutes

Describe your network setup

All lan connected

Burkhardt_Petermann · August 22, 2024, 8:12am

The problem description (really I don’t like the new “wizard”) is not complete:

The problem starts after updating to the latestest update to Roon 2.0 build 1455
server runs on Ubuntu 22.04.4 LTS
server log show me at first, that it can’t mount (DriveNotReady) my local library (and shure, they are all mounted and readable on OS):

08/22 09:59:19 Debug: [broker/locations] Migrating UUID based storage location, id: loc_e4ce11c49a3748c3a6f2a6ae08edef1f, version: 2
08/22 09:59:19 Debug: [broker/locations/migration] start, propname: loc_854ec14843fa4eb988aa9c7f73b07393
08/22 09:59:19 Debug: [broker/locations] Migrating UUID based storage location, id: loc_854ec14843fa4eb988aa9c7f73b07393, version: 2
08/22 09:59:19 Debug: [broker/locations/migration] start, propname: loc_4651f80690754c779f1ce2cb977a4e0c
08/22 09:59:19 Debug: [broker/locations] Migrating UUID based storage location, id: loc_4651f80690754c779f1ce2cb977a4e0c, version: 2
08/22 09:59:19 Debug: [broker/locations/migration] start, propname: loc_baf7026345fb4473a5a3e92996396349
08/22 09:59:19 Debug: [broker/locations] Migrating UUID based storage location, id: loc_baf7026345fb4473a5a3e92996396349, version: 2
08/22 09:59:19 Debug: [broker/locations/migration] start, propname: loc_7d23fa24bf11411baa4cd88c37dc5c70
08/22 09:59:19 Debug: [broker/locations] Migrating UUID based storage location, id: loc_7d23fa24bf11411baa4cd88c37dc5c70, version: 2
08/22 09:59:19 Debug: [broker/locations/migration] start, propname: location_automounts
08/22 09:59:19 Debug: [broker/locations/migration] start, propname: loc_09a829f7cdf14d2da1ecb7ba64e4c2f1
08/22 09:59:19 Debug: [broker/locations] Migrating UUID based storage location, id: loc_09a829f7cdf14d2da1ecb7ba64e4c2f1, version: 2
08/22 09:59:19 Debug: [broker/locations/migration] start, propname: loc_8b9fb78b598347aca9c1ee84d8250d6d
08/22 09:59:19 Debug: [broker/locations] Migrating UUID based storage location, id: loc_8b9fb78b598347aca9c1ee84d8250d6d, version: 2
08/22 09:59:19 Debug: [broker/locations] load pre 1.3 automounts, strlist:
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] initializing FileBrowser.Entry:  / : /media1/music_hd/Pop, drive availability is: False
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] drive is not available so disposing resources (if they exist): FileBrowser.Entry:  / : /media1/music_hd/Pop
08/22 09:59:19 Info: [broker/locations] storage location backend (Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music_hd/Pop:Id=6ba81e65-c977-4fec-bfbb-cd1dc47ac2f8) offline reason changed to: DriveNotReady
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] we'd like to keep this volume mounted: LINUXROOT
08/22 09:59:19 Info: [broker/locations] created enabled location, FileBrowser.Entry:  / : /media1/music_hd/Pop
08/22 09:59:19 Info: [broker/locations] adding storage location: Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music_hd/Pop:Id=6ba81e65-c977-4fec-bfbb-cd1dc47ac2f8
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] initializing FileBrowser.Entry:  / : /media1/music/Hoerbuecher, drive availability is: False
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] drive is not available so disposing resources (if they exist): FileBrowser.Entry:  / : /media1/music/Hoerbuecher
08/22 09:59:19 Info: [broker/locations] storage location backend (Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music/Hoerbuecher:Id=99494e8b-77bc-4e7e-bb6b-2069f565d4fe) offline reason changed to: DriveNotReady
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] we'd like to keep this volume mounted: LINUXROOT
08/22 09:59:19 Info: [broker/locations] created enabled location, FileBrowser.Entry:  / : /media1/music/Hoerbuecher
08/22 09:59:19 Info: [broker/locations] adding storage location: Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music/Hoerbuecher:Id=99494e8b-77bc-4e7e-bb6b-2069f565d4fe
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] initializing FileBrowser.Entry:  / : /media3/music_dsd/Pop, drive availability is: False
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] drive is not available so disposing resources (if they exist): FileBrowser.Entry:  / : /media3/music_dsd/Pop
08/22 09:59:19 Info: [broker/locations] storage location backend (Folder:Name=:Location=FileBrowser.Entry:  / : /media3/music_dsd/Pop:Id=b83537e6-05c8-4e6c-92e3-56e11db194d7) offline reason changed to: DriveNotReady
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] we'd like to keep this volume mounted: LINUXROOT
08/22 09:59:19 Info: [broker/locations] created enabled location, FileBrowser.Entry:  / : /media3/music_dsd/Pop
08/22 09:59:19 Info: [broker/locations] adding storage location: Folder:Name=:Location=FileBrowser.Entry:  / : /media3/music_dsd/Pop:Id=b83537e6-05c8-4e6c-92e3-56e11db194d7
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] initializing FileBrowser.Entry:  / : /media1/music/Radio, drive availability is: False
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] drive is not available so disposing resources (if they exist): FileBrowser.Entry:  / : /media1/music/Radio
08/22 09:59:19 Info: [broker/locations] storage location backend (Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music/Radio:Id=7477e401-5d9a-407d-8cb0-f7165f7cc00e) offline reason changed to: DriveNotReady
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] we'd like to keep this volume mounted: LINUXROOT
08/22 09:59:19 Info: [broker/locations] created enabled location, FileBrowser.Entry:  / : /media1/music/Radio
08/22 09:59:19 Info: [broker/locations] adding storage location: Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music/Radio:Id=7477e401-5d9a-407d-8cb0-f7165f7cc00e
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] initializing FileBrowser.Entry:  / : /media3/music_dsd/Oper, drive availability is: False
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] drive is not available so disposing resources (if they exist): FileBrowser.Entry:  / : /media3/music_dsd/Oper
08/22 09:59:19 Info: [broker/locations] storage location backend (Folder:Name=:Location=FileBrowser.Entry:  / : /media3/music_dsd/Oper:Id=402609c9-b788-45c6-9dad-b113a0a595a4) offline reason changed to: DriveNotReady
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] we'd like to keep this volume mounted: LINUXROOT
08/22 09:59:19 Info: [broker/locations] created enabled location, FileBrowser.Entry:  / : /media3/music_dsd/Oper
08/22 09:59:19 Info: [broker/locations] adding storage location: Folder:Name=:Location=FileBrowser.Entry:  / : /media3/music_dsd/Oper:Id=402609c9-b788-45c6-9dad-b113a0a595a4
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] initializing FileBrowser.Entry:  / : /media1/music/Pop, drive availability is: False
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] drive is not available so disposing resources (if they exist): FileBrowser.Entry:  / : /media1/music/Pop
08/22 09:59:19 Info: [broker/locations] storage location backend (Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music/Pop:Id=e4ce11c4-9a37-48c3-a6f2-a6ae08edef1f) offline reason changed to: DriveNotReady
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] we'd like to keep this volume mounted: LINUXROOT
08/22 09:59:19 Info: [broker/locations] created enabled location, FileBrowser.Entry:  / : /media1/music/Pop
08/22 09:59:19 Info: [broker/locations] adding storage location: Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music/Pop:Id=e4ce11c4-9a37-48c3-a6f2-a6ae08edef1f
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] initializing FileBrowser.Entry:  / : /media1/music/Klassik, drive availability is: False
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] drive is not available so disposing resources (if they exist): FileBrowser.Entry:  / : /media1/music/Klassik
08/22 09:59:19 Info: [broker/locations] storage location backend (Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music/Klassik:Id=854ec148-43fa-4eb9-88aa-9c7f73b07393) offline reason changed to: DriveNotReady
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] we'd like to keep this volume mounted: LINUXROOT
08/22 09:59:19 Info: [broker/locations] created enabled location, FileBrowser.Entry:  / : /media1/music/Klassik
08/22 09:59:19 Info: [broker/locations] adding storage location: Folder:Name=:Location=FileBrowser.Entry:  / : /media1/music/Klassik:Id=854ec148-43fa-4eb9-88aa-9c7f73b07393
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] initializing FileBrowser.Entry:  / : /media2/music_dsd/Klassik, drive availability is: False
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] drive is not available so disposing resources (if they exist): FileBrowser.Entry:  / : /media2/music_dsd/Klassik
08/22 09:59:19 Info: [broker/locations] storage location backend (Folder:Name=:Location=FileBrowser.Entry:  / : /media2/music_dsd/Klassik:Id=4651f806-9075-4c77-9f1c-e2cb977a4e0c) offline reason changed to: DriveNotReady
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] we'd like to keep this volume mounted: LINUXROOT
08/22 09:59:19 Info: [broker/locations] created enabled location, FileBrowser.Entry:  / : /media2/music_dsd/Klassik
08/22 09:59:19 Info: [broker/locations] adding storage location: Folder:Name=:Location=FileBrowser.Entry:  / : /media2/music_dsd/Klassik:Id=4651f806-9075-4c77-9f1c-e2cb977a4e0c
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] initializing FileBrowser.Entry:  / : /media1/music/Aufnahmen, drive availability is: False
08/22 09:59:19 Info: [broker/locations/directorystoragelocation] drive is not available so disposing resources (if they exist): FileBrowser.Entry:  / : /media1/music/Aufnahmen

I’ve also recovered from an update from this night, but it doesn’t resolves the problem

daniel · August 22, 2024, 4:10pm

Hi @Burkhardt_Petermann,
Thank you for writing in to ask about this issue. I wanted to clarify a few things about the issue you are having. You say Roon becomes unresponsive during playback. By this do you mean that the Roon client no longer is responding to any input or that the music stops playing? Also is the timestamp shown in your log snippet the last time this issue occurred?

One troubleshooting step you can try is refreshing your server following the below steps.

Stop RoonServer from running in ROCK’s WebUI
Navigate to your ROCK’s Database Location
Find the folder that says “RoonServer”
Rename the “RoonServer” folder to “RoonServer_old”
Restart the RoonServer in the WebUI to generate a new Roon database folder
On the Roon Remotes, press “Use another Roon Server” and connect to the new database

Burkhardt_Petermann · August 22, 2024, 5:24pm

Hi @daniel,

thanks for your answer, but as you can see, that I’m not using Rock, but Ubuntu server with Roon installed on it.
As I’m written before, I’ve restored my database from are a backup (after removing all the databases under RAATServer, RoonGoer and RoonServer) and also after that I’d a lot of connection losts.
Here the output from journalctl -u roonserver after installation the new version:

Aug 22 08:37:45 roonserver systemd[1]: Started RoonServer.
Aug 22 08:37:45 roonserver start.sh[1222]: 00:00:00.001 Info:  get lock file path: /tmp/.rnsgem0-
Aug 22 08:37:45 roonserver start.sh[1222]: 00:00:00.008 Info:  GetLockFile, fd: 35
Aug 22 08:37:45 roonserver start.sh[1222]: 00:00:00.008 Info:  GetLockFile, res: 0
Aug 22 08:37:45 roonserver start.sh[1222]: 00:00:00.008 Trace: Nope, we are the only one running
Aug 22 08:37:45 roonserver start.sh[1222]: Initializing
Aug 22 08:37:45 roonserver start.sh[1222]: Started
Aug 22 08:37:45 roonserver start.sh[1752]: aac_fixed decoder found, checking libavcodec version...
Aug 22 08:37:45 roonserver start.sh[1752]: has mp3float: 1, aac_fixed: 1
Aug 22 08:37:50 roonserver start.sh[1222]: Running
Aug 22 08:39:06 roonserver start.sh[1222]: Not responding
Aug 22 08:39:34 roonserver start.sh[1222]: Running
Aug 22 08:39:54 roonserver start.sh[1222]: Not responding
Aug 22 08:40:24 roonserver start.sh[1222]: Error
Aug 22 08:40:26 roonserver start.sh[1222]: Initializing
Aug 22 08:40:26 roonserver start.sh[1222]: Started
Aug 22 08:40:26 roonserver start.sh[3926]: aac_fixed decoder found, checking libavcodec version...
Aug 22 08:40:26 roonserver start.sh[3926]: has mp3float: 1, aac_fixed: 1
Aug 22 08:40:29 roonserver start.sh[1222]: Running
Aug 22 08:42:04 roonserver systemd[1]: Stopping RoonServer...
Aug 22 08:42:04 roonserver systemd[1]: roonserver.service: Deactivated successfully.
Aug 22 08:42:04 roonserver systemd[1]: Stopped RoonServer.
Aug 22 08:42:04 roonserver systemd[1]: roonserver.service: Consumed 6min 32.646s CPU time.
Aug 22 08:42:13 roonserver systemd[1]: Started RoonServer.
Aug 22 08:42:13 roonserver start.sh[4528]: 00:00:00.000 Info:  get lock file path: /tmp/.rnsgem0-
Aug 22 08:42:13 roonserver start.sh[4528]: 00:00:00.002 Info:  GetLockFile, fd: 35
Aug 22 08:42:13 roonserver start.sh[4528]: 00:00:00.002 Info:  GetLockFile, res: 0
Aug 22 08:42:13 roonserver start.sh[4528]: 00:00:00.002 Trace: Nope, we are the only one running
Aug 22 08:42:13 roonserver start.sh[4528]: Initializing
Aug 22 08:42:13 roonserver start.sh[4528]: Started
Aug 22 08:42:14 roonserver start.sh[4549]: aac_fixed decoder found, checking libavcodec version...
Aug 22 08:42:14 roonserver start.sh[4549]: has mp3float: 1, aac_fixed: 1
Aug 22 08:42:18 roonserver start.sh[4528]: Running
Aug 22 08:43:29 roonserver start.sh[4528]: Not responding
Aug 22 08:44:00 roonserver start.sh[4528]: Error
Aug 22 08:44:02 roonserver start.sh[4528]: Initializing
Aug 22 08:44:02 roonserver start.sh[4528]: Started
Aug 22 08:44:02 roonserver start.sh[5068]: aac_fixed decoder found, checking libavcodec version...
Aug 22 08:44:02 roonserver start.sh[5068]: has mp3float: 1, aac_fixed: 1
Aug 22 08:44:04 roonserver start.sh[4528]: Running
Aug 22 08:44:45 roonserver start.sh[5068]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.CreateException(SocketError error, Boolean forAsyncThrow)
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ReceiveAsync(Socket socket, CancellationToken cancellationToken)
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Net.Sockets.Socket.BeginReceive(Byte[] buffer, Int32 offset, Int32 size, SocketFlags socketFlags, AsyncCallback callback, Object state)
Aug 22 08:44:45 roonserver start.sh[5068]:    at Sooloos.RnetJsonClient._BeginRead()
Aug 22 08:44:45 roonserver start.sh[5068]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Threading.Tasks.AwaitTaskContinuation.RunCallback(ContextCallback callback, Object state, Task& currentTask)
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Threading.Tasks.Task.RunContinuations(Object continuationObject)
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Threading.Tasks.Task`1.TrySetResult(TResult result)
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.InvokeContinuation(Action`1 continuation, Object state, Boolean forceAsync, Boolean requiresExecutionContextFlow)
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Net.Sockets.SocketAsyncEngine.System.Threading.IThreadPoolWorkItem.Execute()
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Threading.ThreadPoolWorkQueue.Dispatch()
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Threading.PortableThreadPool.WorkerThread.WorkerThreadStart()
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Threading.Thread.StartCallback()
Aug 22 08:44:45 roonserver start.sh[5068]: --- End of stack trace from previous location ---
Aug 22 08:44:45 roonserver start.sh[5068]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 22 08:44:45 roonserver start.sh[5068]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 22 08:45:25 roonserver start.sh[4528]: Not responding
Aug 22 08:45:52 roonserver start.sh[4528]: Running
Aug 22 08:46:02 roonserver start.sh[4528]: Not responding
Aug 22 08:46:08 roonserver start.sh[4528]: Running
Aug 22 08:46:31 roonserver start.sh[4528]: Not responding
Aug 22 08:46:48 roonserver start.sh[4528]: Running
Aug 22 08:47:06 roonserver start.sh[4528]: Not responding
Aug 22 08:47:23 roonserver start.sh[4528]: Running
Aug 22 08:47:38 roonserver start.sh[4528]: Not responding
Aug 22 08:48:00 roonserver start.sh[5068]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 22 08:48:00 roonserver start.sh[5068]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 22 08:48:00 roonserver start.sh[5068]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 22 08:48:00 roonserver start.sh[5068]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 22 08:48:00 roonserver start.sh[5068]: --- End of stack trace from previous location ---
Aug 22 08:48:00 roonserver start.sh[5068]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 22 08:48:00 roonserver start.sh[5068]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 22 08:48:09 roonserver start.sh[4528]: Error
Aug 22 08:48:11 roonserver start.sh[4528]: Initializing
Aug 22 08:48:11 roonserver start.sh[4528]: Started
Aug 22 08:48:11 roonserver start.sh[5863]: aac_fixed decoder found, checking libavcodec version...
Aug 22 08:48:11 roonserver start.sh[5863]: has mp3float: 1, aac_fixed: 1
Aug 22 08:48:14 roonserver start.sh[4528]: Running
Aug 22 08:48:37 roonserver systemd[1]: Stopping RoonServer...
Aug 22 08:48:37 roonserver systemd[1]: roonserver.service: Deactivated successfully.
Aug 22 08:48:37 roonserver systemd[1]: Stopped RoonServer.
Aug 22 08:48:37 roonserver systemd[1]: roonserver.service: Consumed 8min 18.277s CPU time.
Aug 22 08:48:37 roonserver systemd[1]: Started RoonServer.
Aug 22 08:48:37 roonserver start.sh[6084]: 00:00:00.000 Info:  get lock file path: /tmp/.rnsgem0-
Aug 22 08:48:37 roonserver start.sh[6084]: 00:00:00.002 Info:  GetLockFile, fd: 35
Aug 22 08:48:37 roonserver start.sh[6084]: 00:00:00.002 Info:  GetLockFile, res: 0
Aug 22 08:48:37 roonserver start.sh[6084]: 00:00:00.002 Trace: Nope, we are the only one running
Aug 22 08:48:37 roonserver start.sh[6084]: Initializing
Aug 22 08:48:37 roonserver start.sh[6084]: Started
Aug 22 08:48:37 roonserver start.sh[6105]: aac_fixed decoder found, checking libavcodec version...
Aug 22 08:48:37 roonserver start.sh[6105]: has mp3float: 1, aac_fixed: 1
Aug 22 08:48:42 roonserver start.sh[6084]: Running
Aug 22 08:50:03 roonserver start.sh[6084]: Not responding
Aug 22 08:50:33 roonserver start.sh[6084]: Error
Aug 22 08:50:35 roonserver start.sh[6084]: Initializing
Aug 22 08:50:35 roonserver start.sh[6084]: Started
Aug 22 08:50:35 roonserver start.sh[6573]: aac_fixed decoder found, checking libavcodec version...
Aug 22 08:50:35 roonserver start.sh[6573]: has mp3float: 1, aac_fixed: 1
Aug 22 08:50:38 roonserver start.sh[6084]: Running
Aug 22 08:51:54 roonserver start.sh[6084]: Not responding
Aug 22 08:52:24 roonserver start.sh[6084]: Error
Aug 22 08:52:26 roonserver start.sh[6084]: Initializing
Aug 22 08:52:26 roonserver start.sh[6084]: Started
Aug 22 08:52:26 roonserver start.sh[6942]: aac_fixed decoder found, checking libavcodec version...
Aug 22 08:52:26 roonserver start.sh[6942]: has mp3float: 1, aac_fixed: 1
Aug 22 08:52:29 roonserver start.sh[6084]: Running
Aug 22 08:52:46 roonserver systemd[1]: Stopping RoonServer...
Aug 22 08:52:46 roonserver systemd[1]: roonserver.service: Deactivated successfully.
Aug 22 08:52:46 roonserver systemd[1]: Stopped RoonServer.
Aug 22 08:52:46 roonserver systemd[1]: roonserver.service: Consumed 6min 7.914s CPU time.
-- Boot 0645ef99e44d48018313d08c19269cc8 --
Aug 22 08:53:42 roonserver systemd[1]: Started RoonServer.
Aug 22 08:53:42 roonserver start.sh[1214]: 00:00:00.000 Info:  get lock file path: /tmp/.rnsgem0-
Aug 22 08:53:42 roonserver start.sh[1214]: 00:00:00.006 Info:  GetLockFile, fd: 35
Aug 22 08:53:42 roonserver start.sh[1214]: 00:00:00.006 Info:  GetLockFile, res: 0
Aug 22 08:53:42 roonserver start.sh[1214]: 00:00:00.006 Trace: Nope, we are the only one running
Aug 22 08:53:43 roonserver start.sh[1214]: Initializing
Aug 22 08:53:43 roonserver start.sh[1214]: Started
Aug 22 08:53:43 roonserver start.sh[1809]: aac_fixed decoder found, checking libavcodec version...
Aug 22 08:53:43 roonserver start.sh[1809]: has mp3float: 1, aac_fixed: 1
Aug 22 08:53:48 roonserver start.sh[1214]: Running
Aug 22 08:55:27 roonserver start.sh[1214]: Not responding
Aug 22 08:55:35 roonserver start.sh[1214]: Running
Aug 22 09:09:05 roonserver start.sh[1214]: Not running
Aug 22 09:09:07 roonserver start.sh[1214]: Initializing
Aug 22 09:09:07 roonserver start.sh[1214]: Started
Aug 22 09:09:12 roonserver start.sh[5915]: aac_fixed decoder found, checking libavcodec version...
Aug 22 09:09:12 roonserver start.sh[5915]: has mp3float: 1, aac_fixed: 1
Aug 22 09:09:12 roonserver start.sh[1214]: Running
Aug 22 09:11:07 roonserver start.sh[1214]: Not responding
Aug 22 09:11:12 roonserver start.sh[1214]: Running
Aug 22 09:12:55 roonserver start.sh[1214]: Not responding
Aug 22 09:13:03 roonserver start.sh[1214]: Running
Aug 22 09:14:20 roonserver start.sh[1214]: Not responding
Aug 22 09:14:28 roonserver start.sh[1214]: Running
Aug 22 09:14:45 roonserver start.sh[1214]: Not responding
Aug 22 09:14:50 roonserver start.sh[1214]: Running
Aug 22 09:16:00 roonserver start.sh[1214]: Not responding
Aug 22 09:16:07 roonserver start.sh[1214]: Running
Aug 22 09:16:24 roonserver start.sh[1214]: Not responding
Aug 22 09:16:32 roonserver start.sh[1214]: Running
Aug 22 09:16:47 roonserver start.sh[1214]: Not responding
Aug 22 09:16:53 roonserver start.sh[1214]: Running
Aug 22 09:17:54 roonserver start.sh[1214]: Not responding
Aug 22 09:17:59 roonserver start.sh[1214]: Running
Aug 22 09:18:24 roonserver start.sh[1214]: Not responding
Aug 22 09:18:32 roonserver start.sh[1214]: Running
Aug 22 09:19:29 roonserver start.sh[1214]: Not responding
Aug 22 09:19:35 roonserver start.sh[1214]: Running
Aug 22 09:20:06 roonserver start.sh[1214]: Not responding
Aug 22 09:20:14 roonserver start.sh[1214]: Running
Aug 22 09:21:34 roonserver start.sh[1214]: Not responding
Aug 22 09:21:39 roonserver start.sh[1214]: Running
Aug 22 09:23:04 roonserver start.sh[1214]: Not responding
Aug 22 09:23:10 roonserver start.sh[1214]: Running
Aug 22 09:23:31 roonserver systemd[1]: Stopping RoonServer...
Aug 22 09:23:31 roonserver systemd[1]: roonserver.service: Deactivated successfully.
Aug 22 09:23:31 roonserver systemd[1]: Stopped RoonServer.
Aug 22 09:23:31 roonserver systemd[1]: roonserver.service: Consumed 31min 45.694s CPU time.
Aug 22 09:23:36 roonserver systemd[1]: Started RoonServer.
Aug 22 09:23:36 roonserver start.sh[7470]: 00:00:00.000 Info:  get lock file path: /tmp/.rnsgem0-
Aug 22 09:23:36 roonserver start.sh[7470]: 00:00:00.002 Info:  GetLockFile, fd: 35
Aug 22 09:23:36 roonserver start.sh[7470]: 00:00:00.002 Info:  GetLockFile, res: 0
Aug 22 09:23:36 roonserver start.sh[7470]: 00:00:00.002 Trace: Nope, we are the only one running
Aug 22 09:23:36 roonserver start.sh[7470]: Initializing
Aug 22 09:23:36 roonserver start.sh[7470]: Started
Aug 22 09:23:36 roonserver start.sh[7491]: aac_fixed decoder found, checking libavcodec version...
Aug 22 09:23:36 roonserver start.sh[7491]: has mp3float: 1, aac_fixed: 1
Aug 22 09:23:41 roonserver start.sh[7470]: Running
Aug 22 09:24:46 roonserver start.sh[7470]: Not responding
Aug 22 09:25:04 roonserver start.sh[7470]: Running
Aug 22 09:25:14 roonserver start.sh[7470]: Not responding
Aug 22 09:25:19 roonserver start.sh[7470]: Running
Aug 22 09:25:30 roonserver start.sh[7470]: Not responding
Aug 22 09:25:37 roonserver start.sh[7470]: Running
Aug 22 09:25:47 roonserver start.sh[7470]: Not responding
Aug 22 09:26:18 roonserver start.sh[7470]: Error
Aug 22 09:26:20 roonserver start.sh[7470]: Initializing
Aug 22 09:26:20 roonserver start.sh[7470]: Started
Aug 22 09:26:20 roonserver start.sh[8554]: aac_fixed decoder found, checking libavcodec version...
Aug 22 09:26:20 roonserver start.sh[8554]: has mp3float: 1, aac_fixed: 1
Aug 22 09:26:23 roonserver start.sh[7470]: Running
Aug 22 09:27:35 roonserver start.sh[7470]: Not responding
Aug 22 09:28:05 roonserver start.sh[7470]: Error
Aug 22 09:28:07 roonserver start.sh[7470]: Initializing
Aug 22 09:28:07 roonserver start.sh[7470]: Started
Aug 22 09:28:07 roonserver start.sh[9007]: aac_fixed decoder found, checking libavcodec version...
Aug 22 09:28:08 roonserver start.sh[9007]: has mp3float: 1, aac_fixed: 1
Aug 22 09:28:10 roonserver start.sh[7470]: Running
Aug 22 09:30:06 roonserver start.sh[9007]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.CreateException(SocketError error, Boolean forAsyncThrow)
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ReceiveAsync(Socket socket, CancellationToken cancellationToken)
Aug 22 09:30:06 roonserver start.sh[9007]:    at Sooloos.RnetJsonClient._BeginRead()
Aug 22 09:30:06 roonserver start.sh[9007]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state)
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Threading.Tasks.AwaitTaskContinuation.RunCallback(ContextCallback callback, Object state, Task& currentTask)
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Threading.Tasks.Task.RunContinuations(Object continuationObject)
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Threading.Tasks.Task`1.TrySetResult(TResult result)
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.InvokeContinuation(Action`1 continuation, Object state, Boolean forceAsync, Boolean requiresExecutionContextFlow)
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Net.Sockets.SocketAsyncEngine.System.Threading.IThreadPoolWorkItem.Execute()
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Threading.ThreadPoolWorkQueue.Dispatch()
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Threading.PortableThreadPool.WorkerThread.WorkerThreadStart()
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Threading.Thread.StartCallback()
Aug 22 09:30:06 roonserver start.sh[9007]: --- End of stack trace from previous location ---
Aug 22 09:30:06 roonserver start.sh[9007]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 22 09:30:06 roonserver start.sh[9007]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 22 09:36:01 roonserver start.sh[7470]: Not responding
Aug 22 09:36:11 roonserver start.sh[7470]: Running
Aug 22 09:40:24 roonserver start.sh[7470]: Not responding
Aug 22 09:40:29 roonserver start.sh[7470]: Running
Aug 22 09:47:49 roonserver systemd[1]: Stopping RoonServer...
Aug 22 09:47:49 roonserver systemd[1]: roonserver.service: Deactivated successfully.
Aug 22 09:47:49 roonserver systemd[1]: Stopped RoonServer.
Aug 22 09:47:49 roonserver systemd[1]: roonserver.service: Consumed 28min 3.590s CPU time.
Aug 22 09:47:49 roonserver systemd[1]: Started RoonServer.
Aug 22 09:47:49 roonserver start.sh[12014]: 00:00:00.000 Info:  get lock file path: /tmp/.rnsgem0-
Aug 22 09:47:49 roonserver start.sh[12014]: 00:00:00.002 Info:  GetLockFile, fd: 35
Aug 22 09:47:49 roonserver start.sh[12014]: 00:00:00.002 Info:  GetLockFile, res: 0
Aug 22 09:47:49 roonserver start.sh[12014]: 00:00:00.002 Trace: Nope, we are the only one running
Aug 22 09:47:49 roonserver start.sh[12014]: Initializing
Aug 22 09:47:49 roonserver start.sh[12014]: Started
Aug 22 09:47:49 roonserver start.sh[12036]: aac_fixed decoder found, checking libavcodec version...
Aug 22 09:47:49 roonserver start.sh[12036]: has mp3float: 1, aac_fixed: 1
Aug 22 09:47:54 roonserver start.sh[12014]: Running
Aug 22 09:48:34 roonserver start.sh[12014]: Not responding
Aug 22 09:48:39 roonserver start.sh[12014]: Running
Aug 22 09:49:10 roonserver start.sh[12014]: Not responding
Aug 22 09:49:40 roonserver start.sh[12014]: Error
Aug 22 09:49:42 roonserver start.sh[12014]: Initializing
Aug 22 09:49:42 roonserver start.sh[12014]: Started
Aug 22 09:49:42 roonserver start.sh[12571]: aac_fixed decoder found, checking libavcodec version...
Aug 22 09:49:42 roonserver start.sh[12571]: has mp3float: 1, aac_fixed: 1
Aug 22 09:49:45 roonserver start.sh[12014]: Running
Aug 22 09:50:51 roonserver start.sh[12014]: Not responding
Aug 22 09:50:59 roonserver start.sh[12014]: Running
Aug 22 09:51:09 roonserver start.sh[12014]: Not responding
Aug 22 09:51:36 roonserver start.sh[12014]: Running
Aug 22 09:51:51 roonserver start.sh[12014]: Not responding
Aug 22 09:52:22 roonserver start.sh[12014]: Error
Aug 22 09:52:24 roonserver start.sh[12014]: Initializing
Aug 22 09:52:24 roonserver start.sh[12014]: Started
Aug 22 09:52:24 roonserver start.sh[13098]: aac_fixed decoder found, checking libavcodec version...
Aug 22 09:52:24 roonserver start.sh[13098]: has mp3float: 1, aac_fixed: 1
Aug 22 09:52:26 roonserver start.sh[12014]: Running
Aug 22 09:53:43 roonserver start.sh[12014]: Not responding
Aug 22 09:53:50 roonserver start.sh[12014]: Running
Aug 22 09:54:00 roonserver start.sh[12014]: Not responding
Aug 22 09:54:20 roonserver start.sh[12014]: Running
Aug 22 09:54:30 roonserver start.sh[12014]: Not responding
Aug 22 09:54:45 roonserver start.sh[12014]: Running
Aug 22 09:54:55 roonserver start.sh[12014]: Not responding
Aug 22 09:55:03 roonserver start.sh[12014]: Running
Aug 22 09:55:13 roonserver start.sh[12014]: Not responding
Aug 22 09:55:43 roonserver start.sh[12014]: Error
Aug 22 09:55:45 roonserver start.sh[12014]: Initializing
Aug 22 09:55:45 roonserver start.sh[12014]: Started
Aug 22 09:55:46 roonserver start.sh[14216]: aac_fixed decoder found, checking libavcodec version...
Aug 22 09:55:46 roonserver start.sh[14216]: has mp3float: 1, aac_fixed: 1
Aug 22 09:55:48 roonserver start.sh[12014]: Running
Aug 22 09:57:00 roonserver start.sh[12014]: Not responding
Aug 22 09:57:06 roonserver start.sh[12014]: Running
Aug 22 09:57:16 roonserver start.sh[12014]: Not responding
Aug 22 09:57:24 roonserver start.sh[12014]: Running
Aug 22 09:57:34 roonserver start.sh[12014]: Not responding
Aug 22 09:58:03 roonserver start.sh[12014]: Running
Aug 22 09:58:19 roonserver start.sh[12014]: Not responding
Aug 22 09:58:27 roonserver start.sh[12014]: Running
Aug 22 09:58:46 roonserver start.sh[12014]: Not responding
Aug 22 09:59:17 roonserver start.sh[12014]: Error
Aug 22 09:59:19 roonserver start.sh[12014]: Initializing
Aug 22 09:59:19 roonserver start.sh[12014]: Started
Aug 22 09:59:19 roonserver start.sh[15108]: aac_fixed decoder found, checking libavcodec version...
Aug 22 09:59:19 roonserver start.sh[15108]: has mp3float: 1, aac_fixed: 1
Aug 22 09:59:21 roonserver start.sh[12014]: Running
Aug 22 10:03:35 roonserver start.sh[12014]: Not responding
Aug 22 10:03:40 roonserver start.sh[12014]: Running
Aug 22 10:24:32 roonserver start.sh[12014]: Not responding
Aug 22 10:24:40 roonserver start.sh[12014]: Running
Aug 22 11:21:07 roonserver start.sh[15108]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 22 11:21:07 roonserver start.sh[15108]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 22 11:21:07 roonserver start.sh[15108]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 22 11:21:07 roonserver start.sh[15108]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 22 11:21:07 roonserver start.sh[15108]: --- End of stack trace from previous location ---
Aug 22 11:21:07 roonserver start.sh[15108]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 22 11:21:07 roonserver start.sh[15108]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:21:25 roonserver start.sh[15108]: [AAC/oop] GOT 44100/24/2 88097 samples mf=0x79dc14027ed0 underlying_objecttype=-1 underlying_sfidx=-1
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:21:25 roonserver start.sh[15108]: [AAC/oop] GOT 44100/24/2 88097 samples mf=0x79db1c011320 underlying_objecttype=-1 underlying_sfidx=-1
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:21:25 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:21:25 roonserver start.sh[15108]: [AAC/oop] GOT 44100/24/2 109986 samples mf=0x79dd380034f0 underlying_objecttype=-1 underlying_sfidx=-1
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:51:16 roonserver start.sh[15108]: [AAC/oop] GOT 44100/24/2 88097 samples mf=0x79dac8006d50 underlying_objecttype=-1 underlying_sfidx=-1
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:51:16 roonserver start.sh[15108]: [AAC/oop] GOT 44100/24/2 88097 samples mf=0x79db3000ce60 underlying_objecttype=-1 underlying_sfidx=-1
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sgpd
Aug 22 11:51:16 roonserver start.sh[15108]: (stbl) unknown chunk id: sbgp
Aug 22 11:51:16 roonserver start.sh[15108]: [AAC/oop] GOT 44100/24/2 109986 samples mf=0x79dac8006e40 underlying_objecttype=-1 underlying_sfidx=-1
-- Boot 003552de08c24c4a9b87bab73bb37cc8 --
Aug 22 15:05:53 roonserver systemd[1]: Started RoonServer.
Aug 22 15:05:53 roonserver start.sh[1238]: 00:00:00.001 Info:  get lock file path: /tmp/.rnsgem0-
Aug 22 15:05:53 roonserver start.sh[1238]: 00:00:00.006 Info:  GetLockFile, fd: 35
Aug 22 15:05:53 roonserver start.sh[1238]: 00:00:00.007 Info:  GetLockFile, res: 0
Aug 22 15:05:53 roonserver start.sh[1238]: 00:00:00.007 Trace: Nope, we are the only one running
Aug 22 15:05:53 roonserver start.sh[1238]: Initializing
Aug 22 15:05:53 roonserver start.sh[1238]: Started
Aug 22 15:05:53 roonserver start.sh[1703]: aac_fixed decoder found, checking libavcodec version...
Aug 22 15:05:53 roonserver start.sh[1703]: has mp3float: 1, aac_fixed: 1
Aug 22 15:05:58 roonserver start.sh[1238]: Running
Aug 22 15:08:06 roonserver start.sh[1703]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 22 15:08:06 roonserver start.sh[1703]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 22 15:08:06 roonserver start.sh[1703]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 22 15:08:06 roonserver start.sh[1703]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 22 15:08:06 roonserver start.sh[1703]: --- End of stack trace from previous location ---
Aug 22 15:08:06 roonserver start.sh[1703]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 22 15:08:06 roonserver start.sh[1703]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 22 15:09:52 roonserver start.sh[1703]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 22 15:09:52 roonserver start.sh[1703]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 22 15:09:52 roonserver start.sh[1703]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 22 15:09:52 roonserver start.sh[1703]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 22 15:09:52 roonserver start.sh[1703]: --- End of stack trace from previous location ---
Aug 22 15:09:52 roonserver start.sh[1703]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 22 15:09:52 roonserver start.sh[1703]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 22 15:10:11 roonserver start.sh[1703]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 22 15:10:11 roonserver start.sh[1703]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 22 15:10:11 roonserver start.sh[1703]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 22 15:10:11 roonserver start.sh[1703]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 22 15:10:11 roonserver start.sh[1703]: --- End of stack trace from previous location ---
Aug 22 15:10:11 roonserver start.sh[1703]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 22 15:10:11 roonserver start.sh[1703]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 22 17:58:49 roonserver start.sh[1703]: (stbl) unknown chunk id: sgpd
Aug 22 17:58:49 roonserver start.sh[1703]: (stbl) unknown chunk id: sbgp
Aug 22 17:58:49 roonserver start.sh[1703]: (stbl) unknown chunk id: sgpd
Aug 22 17:58:49 roonserver start.sh[1703]: (stbl) unknown chunk id: sbgp
Aug 22 17:58:49 roonserver start.sh[1703]: [AAC/oop] GOT 44100/24/2 88097 samples mf=0x74f058025350 underlying_objecttype=-1 underlying_sfidx=-1
Aug 22 17:58:49 roonserver start.sh[1703]: (stbl) unknown chunk id: sgpd
Aug 22 17:58:49 roonserver start.sh[1703]: (stbl) unknown chunk id: sbgp
Aug 22 17:58:49 roonserver start.sh[1703]: (stbl) unknown chunk id: sgpd
Aug 22 17:58:49 roonserver start.sh[1703]: (stbl) unknown chunk id: sbgp
Aug 22 17:58:49 roonserver start.sh[1703]: [AAC/oop] GOT 44100/24/2 88097 samples mf=0x74f12007f380 underlying_objecttype=-1 underlying_sfidx=-1
Aug 22 17:58:50 roonserver start.sh[1703]: (stbl) unknown chunk id: sgpd
Aug 22 17:58:50 roonserver start.sh[1703]: (stbl) unknown chunk id: sbgp
Aug 22 17:58:50 roonserver start.sh[1703]: (stbl) unknown chunk id: sgpd
Aug 22 17:58:50 roonserver start.sh[1703]: (stbl) unknown chunk id: sbgp
Aug 22 17:58:50 roonserver start.sh[1703]: [AAC/oop] GOT 44100/24/2 109986 samples mf=0x74f058037910 underlying_objecttype=-1 underlying_sfidx=-1
Aug 22 18:15:33 roonserver start.sh[1703]: (stbl) unknown chunk id: sgpd
Aug 22 18:15:33 roonserver start.sh[1703]: (stbl) unknown chunk id: sbgp
Aug 22 18:15:33 roonserver start.sh[1703]: (stbl) unknown chunk id: sgpd
Aug 22 18:15:33 roonserver start.sh[1703]: (stbl) unknown chunk id: sbgp
Aug 22 18:15:33 roonserver start.sh[1703]: [AAC/oop] GOT 44100/24/2 81211 samples mf=0x74f1140098f0 underlying_objecttype=-1 underlying_sfidx=-1

In there you can search for “Not responding” and so the latest issue was on 10:24:32…

Now it seems to work (also after reboot), but what I’h done:
For all Roon remotes (Android and Windows) I’d to change the server.

Burkhardt_Petermann · August 26, 2024, 7:42pm

Any news?
Problem isn’t solved. After every Roon start/restart log told me “DriveNotReady” and some times later it starts checking not identified files/albums (I’ve a lot from them, because,I’ve a lot of self made recordings).
This prevents mostly hearing music directly after the Roon server start.
This wasn’t never a problem before build 1455!

connor · August 26, 2024, 10:31pm

Hi @Burkhardt_Petermann,

Diagnostics indicate there’s a second Linux-based RoonServer in the same environment that has been recently active. Did you migrate your RoonServer?

I recommend running a check disk on your storage drive using the Windows machine by it via USB and following these steps.

Type cmd (Command Prompt) in the Start menu search bar, then click Run as administrator.
Type chkdsk and hit Enter. CHKDSK will scan for drive errors and let you know if it found any you should repair, but it won’t try to fix them without a command.

Burkhardt_Petermann · August 30, 2024, 6:52am

Hi @connor,

the second Roon server is running on a qnap and was migrated three years ago to the current one. Now it acts only as backup/Roon endpoint.

All three data drives on the current Roon server are checked (surely not with Windows, because two are internally and all using ext4) and clean.

Problem is not solved.
Yesterday I’ve done:

removed again the database files and imported the latest backup from build 1442.
removed in Roon all data directories and add them again, in the hope it will clean something in the database.

Both doesn’t help. After starting the roon server service, it takes nearly 30 minutes (with many “Not responding” messages) until I can use Roon.

Again the output from journalctl -u roonserver -b:

Aug 29 20:21:38 roonserver systemd[1]: Started RoonServer.
Aug 29 20:21:38 roonserver start.sh[1209]: 00:00:00.001 Info:  get lock file path: /tmp/.rnsgem0-
Aug 29 20:21:38 roonserver start.sh[1209]: 00:00:00.006 Info:  GetLockFile, fd: 35
Aug 29 20:21:38 roonserver start.sh[1209]: 00:00:00.006 Info:  GetLockFile, res: 0
Aug 29 20:21:38 roonserver start.sh[1209]: 00:00:00.006 Trace: Nope, we are the only one running
Aug 29 20:21:38 roonserver start.sh[1209]: Initializing
Aug 29 20:21:38 roonserver start.sh[1209]: Started
Aug 29 20:21:39 roonserver start.sh[1824]: aac_fixed decoder found, checking libavcodec version...
Aug 29 20:21:39 roonserver start.sh[1824]: has mp3float: 1, aac_fixed: 1
Aug 29 20:21:43 roonserver start.sh[1209]: Running
Aug 29 20:22:49 roonserver start.sh[1209]: Not responding
Aug 29 20:23:19 roonserver start.sh[1209]: Error
Aug 29 20:23:21 roonserver start.sh[1209]: Initializing
Aug 29 20:23:21 roonserver start.sh[1209]: Started
Aug 29 20:23:22 roonserver start.sh[3682]: aac_fixed decoder found, checking libavcodec version...
Aug 29 20:23:22 roonserver start.sh[3682]: has mp3float: 1, aac_fixed: 1
Aug 29 20:23:24 roonserver start.sh[1209]: Running
Aug 29 20:24:46 roonserver start.sh[1209]: Not responding
Aug 29 20:25:03 roonserver start.sh[1209]: Running
Aug 29 20:30:36 roonserver start.sh[3682]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 20:30:36 roonserver start.sh[3682]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 20:30:36 roonserver start.sh[3682]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 20:30:36 roonserver start.sh[3682]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 20:30:36 roonserver start.sh[3682]: --- End of stack trace from previous location ---
Aug 29 20:30:36 roonserver start.sh[3682]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 20:30:36 roonserver start.sh[3682]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 29 20:31:46 roonserver start.sh[1209]: Not responding
Aug 29 20:32:17 roonserver start.sh[1209]: Error
Aug 29 20:32:19 roonserver start.sh[1209]: Initializing
Aug 29 20:32:19 roonserver start.sh[1209]: Started
Aug 29 20:32:19 roonserver start.sh[5537]: aac_fixed decoder found, checking libavcodec version...
Aug 29 20:32:19 roonserver start.sh[5537]: has mp3float: 1, aac_fixed: 1
Aug 29 20:32:21 roonserver start.sh[1209]: Running
Aug 29 20:33:07 roonserver start.sh[1209]: Not responding
Aug 29 20:33:22 roonserver start.sh[1209]: Running
Aug 29 20:33:58 roonserver start.sh[1209]: Not responding
Aug 29 20:34:14 roonserver start.sh[1209]: Running
Aug 29 20:34:32 roonserver start.sh[1209]: Not responding
Aug 29 20:34:51 roonserver start.sh[1209]: Running
Aug 29 20:35:01 roonserver start.sh[1209]: Not responding
Aug 29 20:35:08 roonserver start.sh[1209]: Running
Aug 29 20:35:24 roonserver start.sh[1209]: Not responding
Aug 29 20:35:55 roonserver start.sh[1209]: Error
Aug 29 20:35:57 roonserver start.sh[1209]: Initializing
Aug 29 20:35:57 roonserver start.sh[1209]: Started
Aug 29 20:35:57 roonserver start.sh[6241]: aac_fixed decoder found, checking libavcodec version...
Aug 29 20:35:57 roonserver start.sh[6241]: has mp3float: 1, aac_fixed: 1
Aug 29 20:36:00 roonserver start.sh[1209]: Running
Aug 29 20:37:13 roonserver start.sh[1209]: Not responding
Aug 29 20:37:32 roonserver start.sh[1209]: Running
Aug 29 20:37:35 roonserver start.sh[6241]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 20:37:35 roonserver start.sh[6241]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 20:37:35 roonserver start.sh[6241]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 20:37:35 roonserver start.sh[6241]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 20:37:35 roonserver start.sh[6241]: --- End of stack trace from previous location ---
Aug 29 20:37:35 roonserver start.sh[6241]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 20:37:35 roonserver start.sh[6241]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 29 20:37:42 roonserver start.sh[1209]: Not responding
Aug 29 20:37:50 roonserver start.sh[1209]: Running
Aug 29 20:38:07 roonserver start.sh[1209]: Not responding
Aug 29 20:38:13 roonserver start.sh[1209]: Running
Aug 29 20:38:23 roonserver start.sh[1209]: Not responding
Aug 29 20:38:32 roonserver start.sh[1209]: Running
Aug 29 20:38:50 roonserver start.sh[1209]: Not responding
Aug 29 20:39:09 roonserver start.sh[1209]: Running
Aug 29 20:39:34 roonserver start.sh[1209]: Not responding
Aug 29 20:39:51 roonserver start.sh[1209]: Running
Aug 29 20:40:08 roonserver start.sh[1209]: Not responding
Aug 29 20:40:18 roonserver start.sh[1209]: Running
Aug 29 20:40:28 roonserver start.sh[1209]: Not responding
Aug 29 20:40:45 roonserver start.sh[1209]: Running
Aug 29 20:40:56 roonserver start.sh[1209]: Not responding
Aug 29 20:41:03 roonserver start.sh[1209]: Running
Aug 29 20:41:30 roonserver start.sh[1209]: Not responding
Aug 29 20:42:00 roonserver start.sh[1209]: Error
Aug 29 20:42:02 roonserver start.sh[1209]: Initializing
Aug 29 20:42:02 roonserver start.sh[1209]: Started
Aug 29 20:42:02 roonserver start.sh[7030]: aac_fixed decoder found, checking libavcodec version...
Aug 29 20:42:02 roonserver start.sh[7030]: has mp3float: 1, aac_fixed: 1
Aug 29 20:42:05 roonserver start.sh[1209]: Running
Aug 29 20:45:08 roonserver start.sh[1209]: Not responding
Aug 29 20:45:13 roonserver start.sh[1209]: Running
Aug 29 20:51:25 roonserver start.sh[7030]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 20:51:25 roonserver start.sh[7030]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 20:51:25 roonserver start.sh[7030]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 20:51:25 roonserver start.sh[7030]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 20:51:25 roonserver start.sh[7030]: --- End of stack trace from previous location ---
Aug 29 20:51:25 roonserver start.sh[7030]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 20:51:25 roonserver start.sh[7030]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 29 20:58:52 roonserver start.sh[7030]: (stbl) unknown chunk id: sgpd
....
Aug 29 21:00:05 roonserver start.sh[7030]: (stbl) unknown chunk id: sgpd
Aug 29 21:00:05 roonserver start.sh[7030]: (stbl) unknown chunk id: sbgp
Aug 29 21:00:05 roonserver start.sh[7030]: (stbl) unknown chunk id: sgpd
Aug 29 21:00:05 roonserver start.sh[7030]: (stbl) unknown chunk id: sbgp
Aug 29 21:06:40 roonserver start.sh[1209]: Not responding
Aug 29 21:06:45 roonserver start.sh[1209]: Running
Aug 29 21:07:57 roonserver start.sh[1209]: Not responding
Aug 29 21:08:02 roonserver start.sh[1209]: Running
Aug 29 21:13:15 roonserver start.sh[1209]: Not responding
Aug 29 21:13:21 roonserver start.sh[1209]: Running
Aug 29 21:19:12 roonserver start.sh[1209]: Not responding
Aug 29 21:19:17 roonserver start.sh[1209]: Running
Aug 29 21:24:59 roonserver start.sh[7030]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 21:24:59 roonserver start.sh[7030]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 21:24:59 roonserver start.sh[7030]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 21:24:59 roonserver start.sh[7030]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 21:24:59 roonserver start.sh[7030]: --- End of stack trace from previous location ---
Aug 29 21:24:59 roonserver start.sh[7030]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 21:24:59 roonserver start.sh[7030]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 29 21:29:29 roonserver start.sh[1209]: Not responding
Aug 29 21:29:34 roonserver start.sh[1209]: Running
Aug 29 21:42:58 roonserver start.sh[7030]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 21:42:58 roonserver start.sh[7030]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 21:42:58 roonserver start.sh[7030]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 21:42:58 roonserver start.sh[7030]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 21:42:58 roonserver start.sh[7030]: --- End of stack trace from previous location ---
Aug 29 21:42:58 roonserver start.sh[7030]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 21:42:58 roonserver start.sh[7030]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 29 21:51:07 roonserver start.sh[7030]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 21:51:07 roonserver start.sh[7030]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 21:51:07 roonserver start.sh[7030]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 21:51:07 roonserver start.sh[7030]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 21:51:07 roonserver start.sh[7030]: --- End of stack trace from previous location ---
Aug 29 21:51:07 roonserver start.sh[7030]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 21:51:07 roonserver start.sh[7030]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 29 21:54:39 roonserver systemd[1]: Stopping RoonServer...
Aug 29 21:54:39 roonserver systemd[1]: roonserver.service: Deactivated successfully.
Aug 29 21:54:39 roonserver systemd[1]: Stopped RoonServer.
Aug 29 21:54:39 roonserver systemd[1]: roonserver.service: Consumed 1h 20min 27.955s CPU time.
Aug 29 21:54:39 roonserver systemd[1]: Started RoonServer.
Aug 29 21:54:39 roonserver start.sh[14947]: 00:00:00.000 Info:  get lock file path: /tmp/.rnsgem0-
Aug 29 21:54:39 roonserver start.sh[14947]: 00:00:00.002 Info:  GetLockFile, fd: 35
Aug 29 21:54:39 roonserver start.sh[14947]: 00:00:00.003 Info:  GetLockFile, res: 0
Aug 29 21:54:39 roonserver start.sh[14947]: 00:00:00.003 Trace: Nope, we are the only one running
Aug 29 21:54:39 roonserver start.sh[14947]: Initializing
Aug 29 21:54:39 roonserver start.sh[14947]: Started
Aug 29 21:54:39 roonserver start.sh[14968]: aac_fixed decoder found, checking libavcodec version...
Aug 29 21:54:39 roonserver start.sh[14968]: has mp3float: 1, aac_fixed: 1
Aug 29 21:54:44 roonserver start.sh[14947]: Running
Aug 29 21:55:54 roonserver start.sh[14947]: Not responding
Aug 29 21:56:24 roonserver start.sh[14947]: Error
Aug 29 21:56:26 roonserver start.sh[14947]: Initializing
Aug 29 21:56:26 roonserver start.sh[14947]: Started
Aug 29 21:56:27 roonserver start.sh[15984]: aac_fixed decoder found, checking libavcodec version...
Aug 29 21:56:27 roonserver start.sh[15984]: has mp3float: 1, aac_fixed: 1
Aug 29 21:56:29 roonserver start.sh[14947]: Running
Aug 29 21:57:10 roonserver start.sh[14947]: Not responding
Aug 29 21:57:15 roonserver start.sh[14947]: Running
Aug 29 21:57:48 roonserver start.sh[14947]: Not responding
Aug 29 21:57:53 roonserver start.sh[14947]: Running
Aug 29 21:58:18 roonserver start.sh[14947]: Not responding
Aug 29 21:58:35 roonserver start.sh[14947]: Running
Aug 29 21:58:54 roonserver start.sh[14947]: Not responding
Aug 29 21:59:03 roonserver start.sh[14947]: Running
Aug 29 21:59:13 roonserver start.sh[14947]: Not responding
Aug 29 21:59:19 roonserver start.sh[14947]: Running
Aug 29 21:59:29 roonserver start.sh[14947]: Not responding
Aug 29 21:59:57 roonserver start.sh[14947]: Running
Aug 29 22:00:08 roonserver start.sh[14947]: Not responding
Aug 29 22:00:27 roonserver start.sh[14947]: Running
Aug 29 22:00:37 roonserver start.sh[14947]: Not responding
Aug 29 22:00:55 roonserver start.sh[14947]: Running
Aug 29 22:01:05 roonserver start.sh[14947]: Not responding
Aug 29 22:01:10 roonserver start.sh[14947]: Running
Aug 29 22:01:31 roonserver start.sh[14947]: Not responding
Aug 29 22:01:48 roonserver start.sh[14947]: Running
Aug 29 22:01:58 roonserver start.sh[14947]: Not responding
Aug 29 22:02:04 roonserver start.sh[14947]: Running
Aug 29 22:02:21 roonserver start.sh[14947]: Not responding
Aug 29 22:02:28 roonserver start.sh[14947]: Running
Aug 29 22:02:38 roonserver start.sh[14947]: Not responding
Aug 29 22:02:54 roonserver start.sh[14947]: Running
Aug 29 22:03:04 roonserver start.sh[14947]: Not responding
Aug 29 22:03:11 roonserver start.sh[14947]: Running
Aug 29 22:03:21 roonserver start.sh[14947]: Not responding
Aug 29 22:03:28 roonserver start.sh[14947]: Running
Aug 29 22:03:38 roonserver start.sh[14947]: Not responding
Aug 29 22:04:07 roonserver start.sh[14947]: Running
Aug 29 22:04:38 roonserver start.sh[14947]: Not responding
Aug 29 22:05:07 roonserver start.sh[14947]: Running
Aug 29 22:05:17 roonserver start.sh[14947]: Not responding
Aug 29 22:05:23 roonserver start.sh[14947]: Running
Aug 29 22:05:54 roonserver start.sh[14947]: Not responding
Aug 29 22:06:22 roonserver start.sh[14947]: Running
Aug 29 22:06:39 roonserver start.sh[14947]: Not responding
Aug 29 22:07:09 roonserver start.sh[14947]: Error
Aug 29 22:07:11 roonserver start.sh[14947]: Initializing
Aug 29 22:07:11 roonserver start.sh[14947]: Started
Aug 29 22:07:12 roonserver start.sh[17583]: aac_fixed decoder found, checking libavcodec version...
Aug 29 22:07:12 roonserver start.sh[17583]: has mp3float: 1, aac_fixed: 1
Aug 29 22:07:14 roonserver start.sh[14947]: Running
Aug 29 22:15:42 roonserver start.sh[17583]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 22:15:42 roonserver start.sh[17583]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 22:15:42 roonserver start.sh[17583]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 22:15:42 roonserver start.sh[17583]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 22:15:42 roonserver start.sh[17583]: --- End of stack trace from previous location ---
Aug 29 22:15:42 roonserver start.sh[17583]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 22:15:42 roonserver start.sh[17583]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 29 23:33:16 roonserver start.sh[17583]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 23:33:16 roonserver start.sh[17583]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 23:33:16 roonserver start.sh[17583]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 23:33:16 roonserver start.sh[17583]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 23:33:16 roonserver start.sh[17583]: --- End of stack trace from previous location ---
Aug 29 23:33:16 roonserver start.sh[17583]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 23:33:16 roonserver start.sh[17583]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 29 23:34:40 roonserver start.sh[17583]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 23:34:40 roonserver start.sh[17583]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 23:34:40 roonserver start.sh[17583]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 23:34:40 roonserver start.sh[17583]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 23:34:40 roonserver start.sh[17583]: --- End of stack trace from previous location ---
Aug 29 23:34:40 roonserver start.sh[17583]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 23:34:40 roonserver start.sh[17583]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)
Aug 29 23:35:20 roonserver start.sh[17583]: System.Net.Sockets.SocketException (104): Connection reset by peer
Aug 29 23:35:20 roonserver start.sh[17583]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.ThrowException(SocketError error, CancellationToken cancellationToken)
Aug 29 23:35:20 roonserver start.sh[17583]:    at System.Net.Sockets.Socket.AwaitableSocketAsyncEventArgs.System.Threading.Tasks.Sources.IValueTaskSource<System.Int32>.GetResult(Int16 token)
Aug 29 23:35:20 roonserver start.sh[17583]:    at System.Threading.Tasks.ValueTask`1.ValueTaskSourceAsTask.<>c.<.cctor>b__4_0(Object state)
Aug 29 23:35:20 roonserver start.sh[17583]: --- End of stack trace from previous location ---
Aug 29 23:35:20 roonserver start.sh[17583]:    at System.Threading.Tasks.TaskToApm.End[TResult](IAsyncResult asyncResult)
Aug 29 23:35:20 roonserver start.sh[17583]:    at Sooloos.RnetJsonClient.<>c__DisplayClass65_0.<_BeginRead>b__0(IAsyncResult ar)

This problem starts with build 1455.

Burkhardt_Petermann · August 30, 2024, 6:53am

Don’t know, how to add the RoonServer log itself here…

benjamin · August 30, 2024, 10:07pm

Hey @Burkhardt_Petermann,

According to your account details, this Qnap had Roon Server running just a few hours ago. Can you confirm this second NAS isn’t potentially causing interference with your current setup?

Do you experience the same issue when this machine is powered down?

Can you also test out using a different ethernet cable / port? We’ll be on standby for your reply.

Burkhardt_Petermann · September 3, 2024, 6:25am

No, that are not the causes (Roon on QNAP runs since years in parallel and the my problem was starting with the latest Roon update).

Again:The problem occurs only while starting Roon (the first 10-20 minutes) and after that all is running as expected.
How to upload here the RoonServer log?

daniel · September 4, 2024, 7:49pm

You can upload your logs by using the directions found here and send over a set of logs to our File Uploader?

Burkhardt_Petermann · September 6, 2024, 9:10am

Now I’ve uploaded the RoonServer logs and the output from the roon service.
The situation:
09:41:59 → RoonServer started after system update
10:49:20 → Now it’s finished with the initialization and can used from the endpoints without timeouts

What I’ve done while starting:
10:34 → stopped the roonhttp-api extension through pm2
10:51 → started the roonhttp-api extension trhough pm2
→ changed nothing in the timeouts.

My music lib lies on two internally (each 8TB) SSDs and one external 8TB SSD (through USB).
Why isn’t there an option to exclude dedicated USB devices from scanning while starting the roon core?

Burkhardt_Petermann · September 6, 2024, 9:15am

Changed also the (self generated) title, because the problem occurs only while starting up the roon server service since build 1455.

benjamin · September 10, 2024, 10:00pm

Hi @Burkhardt_Petermann,

Thanks for the above responses.

It is unclear if you’ve attempted a fresh install of Roon, and open it without restoring a backup initially. Is this something you’d be able to test?

Does opening a fresh instance of Roon still take a longer period to load?

Make a Backup of your current RoonServer Database
Exit out of RoonServer
Navigate to your RoonServer’s Database Location
Find the folder that says “RoonServer”
Rename the “RoonServer” folder to “RoonServer_old”
Reinstall the RoonServer App from our Downloads Page to generate a new RoonServer folder
On the Roon Remotes, press “Use another Roon Server” and connect to the new database

Burkhardt_Petermann · September 11, 2024, 4:14pm

Yes.

Not very helpful, all the answers.
Do you’ve checked my sended logs?

noris · September 12, 2024, 2:24pm

Hi @Burkhardt_Petermann ,

In your logs I am seeing a lot of API activity right before the crashes. Can you please confirm if the same issue occurs with extensions temporarily disabled?

Burkhardt_Petermann · September 12, 2024, 2:46pm

Take a look into my posting 6 days ago…

So, now closed without any real help.What a shame for this support

By the way: After the newest Roon update, the problem seems to be solved.

system · September 13, 2024, 2:47pm

This topic was automatically closed 24 hours after the last reply. New replies are no longer allowed.