Roon won't go past initializing

Eve_Fox · October 5, 2021, 11:27pm

Roon Core Machine

UnRaid - Threadripper - 128GB RAM - Docker container

Networking Gear & Setup Details

All hardwired

Number of Tracks in Library

400,000 but also 0.

Description of Issue

Woke up to roon not functioning, currently cannot get it to go past ‘initializing’. I tried gradually removing media folders (occasionally ‘broken’ files end up in there), and didn’t work.
Renamed the roonserver data directory and the app directory, spun up the docker fresh with just a single media source connected, no dice, tried the same process with no media connected, same issue.

Last lines of the logs

10/05 19:17:15 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
10/05 19:17:15 Trace: [push] connecting to 34.75.144.165:9204
10/05 19:17:15 Trace: [push] connected
10/05 19:17:16 Info: [brokerserver] Client connected: 192.168.2.224:19267
10/05 19:17:16 Trace: [SOOD] Adding User IP 192.168.2.224
10/05 19:17:16 Info: [brokerserver] Client connected: 192.168.2.224:19270
10/05 19:17:16 Info: [brokerserver] Client connected: 192.168.2.224:19272
10/05 19:17:16 Info: [brokerserver] Client disconnected: 192.168.2.224:19267
10/05 19:17:16 Info: [brokerserver] Client disconnected: 192.168.2.224:19270
10/05 19:17:16 Trace: SENT NONFINAL DistributedBroker.ConnectResponse={ BrokerId=87f6007c-dbd7-447f-ad54-cac118e0340d BrokerName='Tower' }
10/05 19:17:16 Trace: SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=100800831 DisplayValue='1.8 (build 831) stable' Branch='stable' } }
10/05 19:17:16 Trace: [push] restarting connection (Unable to read data from the transport connection: interrupted.)
10/05 19:17:16 Trace: [push] retrying connection in 64627ms
10/05 19:17:20 Info: [stats] 2914mb Virtual, 194mb Physical, 55mb Managed, 0 Handles, 41 Threads
10/05 19:17:20 Info: [brokerserver] Client disconnected: 192.168.2.224:19272
10/05 19:17:26 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
10/05 19:17:26 Trace: [push] connecting to 34.75.144.165:9204
10/05 19:17:26 Trace: [push] connected
10/05 19:17:30 Info: [brokerserver] Client connected: 192.168.2.224:19285
10/05 19:17:30 Info: [brokerserver] Client connected: 192.168.2.224:19288
10/05 19:17:30 Info: [brokerserver] Client connected: 192.168.2.224:19290
10/05 19:17:30 Info: [brokerserver] Client disconnected: 192.168.2.224:19288
10/05 19:17:30 Info: [brokerserver] Client disconnected: 192.168.2.224:19285
10/05 19:17:30 Trace: SENT NONFINAL DistributedBroker.ConnectResponse={ BrokerId=87f6007c-dbd7-447f-ad54-cac118e0340d BrokerName='Tower' }
10/05 19:17:30 Trace: SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=100800831 DisplayValue='1.8 (build 831) stable' Branch='stable' } }
10/05 19:17:30 Trace: [push] restarting connection (Unable to read data from the transport connection: interrupted.)
10/05 19:17:30 Trace: [push] retrying connection in 51086ms
10/05 19:17:30 Info: [brokerserver] Client disconnected: 192.168.2.224:19290
10/05 19:17:34 Trace: [appupdater] initial check for updates
10/05 19:17:34 Debug: [base/updater] Checking for updates: https://updates.roonlabs.com/update/?v=2&serial=3F778869-8C3D-4A71-ADE0-2E138D6EEA10&userid=&platform=linuxx64&product=RoonServer&branding=roon&curbranch=stable&version=100800831&branch=stable&coredeviceid=87f6007c-dbd7-447f-ad54-cac118e0340d&deviceid=87f6007c-dbd7-447f-ad54-cac118e0340d
10/05 19:17:34 Debug: [appupdater] Update not needed
10/05 19:17:35 Info: [stats] 2983mb Virtual, 200mb Physical, 58mb Managed, 0 Handles, 41 Threads
10/05 19:17:36 Info: Flushing kart data to server
10/05 19:17:36 Debug: server said: 
10/05 19:17:40 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
10/05 19:17:40 Trace: [push] connecting to 34.75.144.165:9204
10/05 19:17:40 Trace: [push] connected
10/05 19:17:50 Info: [stats] 2985mb Virtual, 201mb Physical, 58mb Managed, 0 Handles, 43 Threads
10/05 19:18:05 Info: [stats] 2986mb Virtual, 202mb Physical, 59mb Managed, 0 Handles, 41 Threads
10/05 19:18:20 Info: [stats] 2986mb Virtual, 202mb Physical, 59mb Managed, 0 Handles, 41 Threads
10/05 19:18:30 Info: [brokerserver] Client connected: 192.168.2.224:19340
10/05 19:18:30 Info: [brokerserver] Client disconnected: 192.168.2.224:19340
10/05 19:18:34 Info: [brokerserver] Client connected: 192.168.2.224:19345
10/05 19:18:34 Trace: SENT NONFINAL DistributedBroker.ConnectResponse={ BrokerId=87f6007c-dbd7-447f-ad54-cac118e0340d BrokerName='Tower' }
10/05 19:18:34 Trace: SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=100800831 DisplayValue='1.8 (build 831) stable' Branch='stable' } }
10/05 19:18:34 Trace: [push] restarting connection (Unable to read data from the transport connection: interrupted.)
10/05 19:18:34 Trace: [push] retrying connection in 18020ms
10/05 19:18:35 Info: [stats] 2986mb Virtual, 202mb Physical, 59mb Managed, 0 Handles, 42 Threads
10/05 19:18:44 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
10/05 19:18:44 Trace: [push] connecting to 34.75.144.165:9204
10/05 19:18:44 Trace: [push] connected
10/05 19:18:50 Info: [stats] 2988mb Virtual, 203mb Physical, 59mb Managed, 0 Handles, 45 Threads
10/05 19:19:00 Info: [brokerserver] Client connected: 192.168.2.224:19383
10/05 19:19:00 Info: [brokerserver] Client disconnected: 192.168.2.224:19383
10/05 19:19:05 Info: [stats] 3053mb Virtual, 203mb Physical, 60mb Managed, 0 Handles, 43 Threads
10/05 19:19:20 Info: [stats] 3053mb Virtual, 203mb Physical, 60mb Managed, 0 Handles, 43 Threads
10/05 19:19:35 Info: [stats] 3053mb Virtual, 203mb Physical, 60mb Managed, 0 Handles, 43 Threads
10/05 19:19:50 Info: [stats] 3053mb Virtual, 203mb Physical, 60mb Managed, 0 Handles, 43 Threads
10/05 19:20:05 Info: [stats] 3053mb Virtual, 203mb Physical, 60mb Managed, 0 Handles, 43 Threads
10/05 19:20:20 Info: [stats] 3053mb Virtual, 203mb Physical, 60mb Managed, 0 Handles, 41 Threads
10/05 19:20:30 Info: [brokerserver] Client disconnected: 192.168.2.224:19345
10/05 19:20:30 Trace: [push] restarting connection (Unable to read data from the transport connection: interrupted.)
10/05 19:20:30 Trace: [push] retrying connection in 80694ms
10/05 19:20:35 Info: [stats] 3053mb Virtual, 204mb Physical, 60mb Managed, 0 Handles, 39 Threads
10/05 19:20:40 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
10/05 19:20:40 Trace: [push] connecting to 34.75.144.165:9204
10/05 19:20:40 Trace: [push] connected
10/05 19:20:44 Info: [brokerserver] Client connected: 192.168.2.224:19463
10/05 19:20:44 Info: [brokerserver] Client connected: 192.168.2.224:19466
10/05 19:20:45 Info: [brokerserver] Client disconnected: 192.168.2.224:19463
10/05 19:20:45 Trace: SENT NONFINAL DistributedBroker.ConnectResponse={ BrokerId=87f6007c-dbd7-447f-ad54-cac118e0340d BrokerName='Tower' }
10/05 19:20:45 Trace: SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=100800831 DisplayValue='1.8 (build 831) stable' Branch='stable' } }
10/05 19:20:45 Trace: [push] restarting connection (Unable to read data from the transport connection: interrupted.)
10/05 19:20:45 Trace: [push] retrying connection in 75917ms
10/05 19:20:50 Info: [stats] 3054mb Virtual, 204mb Physical, 60mb Managed, 0 Handles, 41 Threads
10/05 19:20:52 Info: [brokerserver] Client disconnected: 192.168.2.224:19466
10/05 19:20:55 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
10/05 19:20:55 Trace: [push] connecting to 34.75.144.165:9204
10/05 19:20:55 Trace: [push] connected
10/05 19:21:05 Info: [stats] 3054mb Virtual, 204mb Physical, 61mb Managed, 0 Handles, 41 Threads
10/05 19:21:20 Info: [stats] 3054mb Virtual, 205mb Physical, 61mb Managed, 0 Handles, 39 Threads
10/05 19:21:35 Info: [stats] 3054mb Virtual, 205mb Physical, 61mb Managed, 0 Handles, 39 Threads
10/05 19:21:50 Info: [stats] 3054mb Virtual, 205mb Physical, 61mb Managed, 0 Handles, 38 Threads
10/05 19:22:04 Trace: [broker/accounts] [heartbeat] now=10/05/2021 23:22:04 nextauthrefresh=10/06/2021 00:17:05 nextmachineallocate=10/06/2021 03:17:04
10/05 19:22:05 Info: [stats] 3054mb Virtual, 205mb Physical, 61mb Managed, 0 Handles, 39 Threads
10/05 19:22:20 Info: [stats] 3054mb Virtual, 205mb Physical, 61mb Managed, 0 Handles, 37 Threads
10/05 19:22:35 Info: [stats] 3054mb Virtual, 203mb Physical, 61mb Managed, 0 Handles, 35 Threads
10/05 19:22:50 Info: [stats] 3054mb Virtual, 203mb Physical, 61mb Managed, 0 Handles, 34 Threads
10/05 19:23:05 Info: [stats] 3054mb Virtual, 203mb Physical, 61mb Managed, 0 Handles, 34 Threads
10/05 19:23:20 Info: [stats] 3054mb Virtual, 203mb Physical, 61mb Managed, 0 Handles, 34 Threads
10/05 19:23:35 Info: [stats] 3054mb Virtual, 203mb Physical, 61mb Managed, 0 Handles, 34 Threads
10/05 19:23:50 Info: [stats] 3054mb Virtual, 203mb Physical, 61mb Managed, 0 Handles, 33 Threads
10/05 19:24:05 Info: [stats] 3054mb Virtual, 203mb Physical, 61mb Managed, 0 Handles, 33 Threads
10/05 19:24:20 Info: [stats] 3054mb Virtual, 203mb Physical, 61mb Managed, 0 Handles, 32 Threads
10/05 19:24:35 Info: [stats] 3054mb Virtual, 203mb Physical, 61mb Managed, 0 Handles, 31 Threads
10/05 19:24:43 Info: [brokerserver] Client connected: 192.168.2.224:1271
10/05 19:24:43 Info: [brokerserver] Client connected: 192.168.2.224:1274
10/05 19:24:44 Info: [brokerserver] Client connected: 192.168.2.224:1276
10/05 19:24:44 Info: [brokerserver] Client disconnected: 192.168.2.224:1271
10/05 19:24:44 Info: [brokerserver] Client disconnected: 192.168.2.224:1274
10/05 19:24:44 Trace: SENT NONFINAL DistributedBroker.ConnectResponse={ BrokerId=87f6007c-dbd7-447f-ad54-cac118e0340d BrokerName='Tower' }
10/05 19:24:44 Trace: SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=100800831 DisplayValue='1.8 (build 831) stable' Branch='stable' } }
10/05 19:24:44 Trace: [push] restarting connection (Unable to read data from the transport connection: interrupted.)
10/05 19:24:44 Trace: [push] retrying connection in 14152ms
10/05 19:24:47 Info: [brokerserver] Client disconnected: 192.168.2.224:1276
10/05 19:24:50 Info: [stats] 3055mb Virtual, 204mb Physical, 61mb Managed, 0 Handles, 37 Threads

Essentially roon is broken for me and I can’t even start fresh.

Eve_Fox · October 5, 2021, 11:45pm

Same issue is present on windows for me currently too. Can’t even setup a new library.

10/05 19:42:56 Critical: scx: in OnExit: System.NullReferenceException: Object reference not set to an instance of an object.
   at Sooloos.Broker.Music.Library.EndMutation()
   at Sooloos.Broker.Music.Module.ev_exit()
   at Sooloos.SynchronizationContextThread.OnExit()
10/05 19:42:56 Critical: scx: System.NullReferenceException: Object reference not set to an instance of an object.
   at Sooloos.Broker.State.NotifyIsLoggedIn(String userid)
   at Sooloos.Broker.Accounts._DataUpdated()
   at Sooloos.Broker.Accounts.<>c__DisplayClass66_1.<<_FinishLogin>b__1>d.MoveNext()
--- End of stack trace from previous location where exception was thrown ---
   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
   at Sooloos.SynchronizationContextThread._Dispatch(SendOrPostWrapper& ret)
10/05 19:42:56 Trace: [brokerclient] connect timeout
10/05 19:42:56 Critical: scx: in OnExit: System.NullReferenceException: Object reference not set to an instance of an object.
   at Sooloos.Broker.Music.Library.EndMutation()
   at Sooloos.Broker.Music.Module.ev_exit()
   at Sooloos.SynchronizationContextThread.OnExit()
10/05 19:42:56 Trace: [brokerclient] connect timeout
10/05 19:42:56 Critical: scx: in OnExit: System.NullReferenceException: Object reference not set to an instance of an object.
   at Sooloos.Broker.Music.Library.EndMutation()
   at Sooloos.Broker.Music.Module.ev_exit()
   at Sooloos.SynchronizationContextThread.OnExit()
10/05 19:42:57 Trace: GOT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='Checking' HasChangeLog=False CurrentVersion={ MachineValue=100800831 DisplayValue='1.8 (build 831) stable' Branch='stable' } }
10/05 19:42:57 Critical: scx: in OnExit: System.NullReferenceException: Object reference not set to an instance of an object.
   at Sooloos.Broker.Music.Library.EndMutation()
   at Sooloos.Broker.Music.Module.ev_exit()
   at Sooloos.SynchronizationContextThread.OnExit()
10/05 19:42:57 Trace: GOT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=100800831 DisplayValue='1.8 (build 831) stable' Branch='stable' } }
10/05 19:42:57 Critical: scx: in OnExit: System.NullReferenceException: Object reference not set to an instance of an object.
   at Sooloos.Broker.Music.Library.EndMutation()
   at Sooloos.Broker.Music.Module.ev_exit()
   at Sooloos.SynchronizationContextThread.OnExit()
10/05 19:42:58 Trace: [brokerclient] connecting to Tower (f1d59289-4788-4983-8640-b2dbaef0921c) @ 172.22.0.1:9101 (attempt 4/6)
10/05 19:42:58 Critical: scx: in OnExit: System.NullReferenceException: Object reference not set to an instance of an object.
   at Sooloos.Broker.Music.Library.EndMutation()
   at Sooloos.Broker.Music.Module.ev_exit()
   at Sooloos.SynchronizationContextThread.OnExit()
10/05 19:42:58 Trace: [brokerclient] connecting to Tower (f1d59289-4788-4983-8640-b2dbaef0921c) @ 172.17.0.1:9101 (attempt 4/6)
10/05 19:42:58 Critical: scx: in OnExit: System.NullReferenceException: Object reference not set to an instance of an object.
   at Sooloos.Broker.Music.Library.EndMutation()
   at Sooloos.Broker.Music.Module.ev_exit()
   at Sooloos.SynchronizationContextThread.OnExit()
10/05 19:43:00 Warn: exception starting raatserver: System.Net.Sockets.SocketException (0x80004005): No connection could be made because the target machine actively refused it 127.0.0.1:9004
   at System.Net.Sockets.TcpClient..ctor(String hostname, Int32 port)
   at Sooloos.RAATServer.ConnectOrStartAndWaitForExit(String path, String args, Action`1 status, ChildProcess& p)

I can’t login properly. I’ve tried doing this while the Docker on my server was running with no luck either.

beka · October 13, 2021, 8:40pm

Hey @Eve_Fox,

Thanks a whole lot for getting in touch to let us know about this issue you’re experiencing - I am so sorry we didn’t get a chance to reply until today… , especially since you haven’t been able to use Roon at all. Please, accept my sincere apology.

I was wondering if anything has changed since you posted this thread? We’d love to make sure we help as best as we can