Hi @c2c2c2,
We took another look at the logs from your Core and it appears that this issue is networking related, something appears to be causing your network on the NAS to drop, it’s possible that these drops are also causing performance issues. Here is a log snippet showing the network drop:
01/18 08:52:41 Trace: [Master Bedroom] [LowQuality 25.2x, 24/44 MP3 => 24/192] [14% buf] [PLAYING @ 173:39] KPBS
01/18 08:52:41 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Dropout","samples":3946}
01/18 08:52:42 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Dropout","samples":96074}
01/18 08:52:42 Warn: [Master Bedroom] [zoneplayer/raat] long rtt sync Bluesound POWERNODE 2i: realtime=36650169977568 rtt=449500us offset=-36011872022us delta=445068us drift=116227us in 10420.909s (11.153ppm, 40.152ms/hr)
01/18 08:52:43 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Dropout","samples":96074}
01/18 08:52:43 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Dropout","samples":96074}
01/18 08:52:43 Trace: [Master Bedroom] [zoneplayer/raat] sync Bluesound POWERNODE 2i: realtime=36650434580542 rtt=4000us offset=-36012317419us delta=-445397us drift=-329169us in 10422.0615s (-31.584ppm, -113.702ms/hr)
01/18 08:52:43 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Dropout","samples":60016}
01/18 08:52:46 Trace: [Master Bedroom] [LowQuality 25.2x, 24/44 MP3 => 24/192] [14% buf] [PLAYING @ 173:44] KPBS
01/18 08:52:47 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Dropout","samples":86834}
01/18 08:52:48 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Dropout","samples":12244}
01/18 08:52:51 Trace: [Master Bedroom] [LowQuality 25.2x, 24/44 MP3 => 24/192] [14% buf] [PLAYING @ 173:49] KPBS
01/18 08:52:55 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Dropout","samples":37702}
01/18 08:52:55 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Dropout","samples":96074}
01/18 08:52:55 Warn: [Master Bedroom] [zoneplayer/raat] Too many dropouts (>3s dropped out in the last 30s). Killing stream
01/18 08:52:55 Trace: [Master Bedroom] [zoneplayer/raat] too many dropouts. stopping stream
01/18 08:52:55 Warn: [zone Master Bedroom] Track Stopped Due to Slow Media
01/18 08:52:55 Info: [audio/env] [zoneplayer -> stream] All streams were disposed
01/18 08:52:55 Trace: [Master Bedroom] [zoneplayer/raat] Endpoint Bluesound POWERNODE 2i State Changed: Playing => Prepared
01/18 08:52:55 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] SENT [53649]{"request":"end_stream"}
01/18 08:52:55 Debug: [raat/tcpaudiosource] disconnecting
01/18 08:52:55 Info: [audio/env] [zoneplayer -> stream -> endpoint] All streams were disposed
01/18 08:52:55 Warn: [raat/tcpaudiosource] send failed: Object reference not set to an instance of an object
01/18 08:52:55 Warn: [raat/tcpaudiosource] disconnecting + retrying
01/18 08:52:55 Trace: Attempting to play channel URL: hls://http%3a%2f%2fkpbs.media.clients.ellingtoncms.com%2flive%2flisten.m3u
01/18 08:52:55 Warn: [streammediafile] error reading stream: Unable to read data from the transport connection: Operation aborted.
01/18 08:52:55 Info: [audio/env] [zoneplayer] All streams were disposed
01/18 08:52:55 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [31397] {"status":"Ended"}
01/18 08:52:55 Info: [zone Master Bedroom] OnPlayFeedback StoppedEndOfMediaUnnatural
01/18 08:52:55 Info: [zone Master Bedroom] OnPlayFeedback Stopped
01/18 08:52:55 Info: [zone Master Bedroom] Canceling Pending Sleep
01/18 08:52:55 Info: [zone Master Bedroom] Canceling Pending Sleep
01/18 08:52:55 Trace: [Master Bedroom] [LowQuality, 24/44 MP3 => 24/192] [14% buf] [STOPPED @ 0:00] KPBS
01/18 08:52:55 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [53649] {"status":"Success"}
01/18 08:52:55 Info: sleep 200ms after flush
01/18 08:52:55 Info: [Master Bedroom] [zoneplayer] Playing: channel://hls%3a%2f%2fhttp%253a%252f%252fkpbs.media.clients.ellingtoncms.com%252flive%252flisten.m3u
01/18 08:53:05 Warn: [HLS] error kicking off streaming: System.Net.WebException: The operation has timed out.
at System.Net.HttpWebRequest.RunWithTimeoutWorker[T] (System.Threading.Tasks.Task`1[TResult] workerTask, System.Int32 timeout, System.Action abort, System.Func`1[TResult] aborted, System.Threading.CancellationTokenSource cts) [0x000f8] in <a42f1dd5b44448eb83533f7faf608d38>:0
at System.Net.HttpWebRequest.GetResponse () [0x00016] in <a42f1dd5b44448eb83533f7faf608d38>:0
at Sooloos.Audio.HLSAudioSignal+HLSStream..ctor (System.Uri uri) [0x0003d] in <f50ca84da7444893995dececa2d718b0>:0
at (wrapper remoting-invoke-with-check) Sooloos.Audio.HLSAudioSignal+HLSStream..ctor(System.Uri)
at Sooloos.Audio.HLSAudioSignal..ctor (System.String url) [0x00019] in <f50ca84da7444893995dececa2d718b0>:0
01/18 08:53:05 Error: [zoneplayer] Unexpected Failure While Opening Sound: hls://http%3a%2f%2fkpbs.media.clients.ellingtoncms.com%2flive%2flisten.m3u: System.Net.WebException: The operation has timed out.
at System.Net.HttpWebRequest.RunWithTimeoutWorker[T] (System.Threading.Tasks.Task`1[TResult] workerTask, System.Int32 timeout, System.Action abort, System.Func`1[TResult] aborted, System.Threading.CancellationTokenSource cts) [0x000f8] in <a42f1dd5b44448eb83533f7faf608d38>:0
at System.Net.HttpWebRequest.GetResponse () [0x00016] in <a42f1dd5b44448eb83533f7faf608d38>:0
at Sooloos.Audio.HLSAudioSignal+HLSStream..ctor (System.Uri uri) [0x0003d] in <f50ca84da7444893995dececa2d718b0>:0
at (wrapper remoting-invoke-with-check) Sooloos.Audio.HLSAudioSignal+HLSStream..ctor(System.Uri)
at Sooloos.Audio.HLSAudioSignal..ctor (System.String url) [0x0013e] in <f50ca84da7444893995dececa2d718b0>:0
at Sooloos.Broker.Transport.AudioSignalFactory+<>c__DisplayClass0_0.<Create>b__0 (Sooloos.CallingThread cx) [0x0014b] in <d4adb948e806436690e64f0c72e9fcd0>:0
01/18 08:53:05 Info: [Master Bedroom] [zoneplayer] Open Result (Playing):Result[Status=UnexpectedError]
01/18 08:53:24 Trace: [broker/accounts] [heartbeat] now=1/18/2021 4:53:24 PM nextauthrefresh=1/18/2021 5:48:25 PM nextmachineallocate=1/18/2021 8:48:24 PM
01/18 08:53:35 Critical: [easyhttp] [1732] Post https://internetradio.roonlabs.net/2/api/reporting/internetradioplayback/events?format=msgpack web exception without response: : System.Net.WebException: Error: NameResolutionFailure
at System.Net.WebConnection.Connect (System.Net.WebOperation operation, System.Threading.CancellationToken cancellationToken) [0x00044] in <a42f1dd5b44448eb83533f7faf608d38>:0
at System.Net.WebConnection.InitConnection (System.Net.WebOperation operation, System.Threading.CancellationToken cancellationToken) [0x000cc] in <a42f1dd5b44448eb83533f7faf608d38>:0
at System.Net.WebOperation.Run () [0x0009a] in <a42f1dd5b44448eb83533f7faf608d38>:0
at System.Net.WebCompletionSource`1[T].WaitForCompletion () [0x00094] in <a42f1dd5b44448eb83533f7faf608d38>:0
at System.Net.HttpWebRequest.RunWithTimeoutWorker[T] (System.Threading.Tasks.Task`1[TResult] workerTask, System.Int32 timeout, System.Action abort, System.Func`1[TResult] aborted, System.Threading.CancellationTokenSource cts) [0x000f8] in <a42f1dd5b44448eb83533f7faf608d38>:0
at System.Net.HttpWebRequest.EndGetRequestStream (System.IAsyncResult asyncResult) [0x00020] in <a42f1dd5b44448eb83533f7faf608d38>:0
at System.Threading.Tasks.TaskFactory`1[TResult].FromAsyncCoreLogic (System.IAsyncResult iar, System.Func`2[T,TResult] endFunction, System.Action`1[T] endAction, System.Threading.Tasks.Task`1[TResult] promise, System.Boolean requiresSynchronization) [0x0000f] in <2a87bd31dcff47ba852a26f462914885>:0
--- End of stack trace from previous location where exception was thrown ---
at Sooloos.EasyHttp.QueryAsync (Sooloos.EasyHttp+HttpMethod method, Sooloos.EasyHttp+Params p, System.Threading.CancellationToken canceltoken) [0x0059d] in <88f4827addc444c2b98f7f2b80c32f3b>:0
01/18 08:53:45 Trace: [raat_ll/client] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] no data received for >10000ms. Killing connection.
01/18 08:53:45 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => Disconnected
01/18 08:53:45 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] lost client connection. Retrying
01/18 08:53:45 Trace: [push] restarting connection (Unable to read data from the transport connection: interrupted.)
01/18 08:53:45 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] connecting (attempt 1)
01/18 08:53:45 Trace: [push] retrying connection in 62270ms
01/18 08:53:45 Info: [transport] destroyed zone Master Bedroom was playing? False
01/18 08:53:45 Trace: [zone Master Bedroom] Suspend
01/18 08:53:45 Info: [zone Master Bedroom] Canceling Pending Sleep
01/18 08:53:45 Info: [zone Master Bedroom] Canceling Pending Sleep
01/18 08:53:45 Trace: [Master Bedroom] [zoneplayer/raat] Endpoint Bluesound POWERNODE 2i State Changed: Prepared => Idle
01/18 08:53:45 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => Connecting
01/18 08:53:55 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => ConnectionFailed
01/18 08:53:55 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] client connection failed. Retrying in 500ms
01/18 08:53:56 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] connecting (attempt 2)
01/18 08:53:56 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => Connecting
01/18 08:54:05 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 08:54:05 Trace: [push] request to manager failed
01/18 08:54:05 Trace: [push] retrying connection in 85781ms
01/18 08:54:06 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => ConnectionFailed
01/18 08:54:06 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] client connection failed. Retrying in 750ms
01/18 08:54:07 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] connecting (attempt 3)
01/18 08:54:07 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => Connecting
01/18 08:54:15 Debug: [easyhttp] [1733] POST to https://internetradio.roonlabs.net/2/api/reporting/internetradioplayback/events?format=msgpack timed out after 80065 ms
01/18 08:54:17 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => ConnectionFailed
01/18 08:54:17 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] client connection failed. Retrying in 1125ms
01/18 08:54:18 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] connecting (attempt 4)
01/18 08:54:18 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => Connecting
01/18 08:54:28 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => ConnectionFailed
01/18 08:54:28 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] client connection failed. Retrying in 1687ms
01/18 08:54:30 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] connecting (attempt 5)
01/18 08:54:30 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => Connecting
01/18 08:54:40 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => ConnectionFailed
01/18 08:54:40 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] client connection failed. Giving up
01/18 08:54:55 Debug: [easyhttp] [1734] POST to https://internetradio.roonlabs.net/2/api/reporting/internetradioplayback/plays?format=msgpack timed out after 80047 ms
01/18 08:55:00 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 08:55:00 Trace: [push] request to manager failed
01/18 08:55:00 Trace: [push] retrying connection in 200188ms
01/18 08:55:07 Trace: [airplay] expired device AirPlayDevice[DeviceId=9056827FA5BB@BS Bedroom._raop._tcp.local, Name=BSBedroom.local, Model=POWERNODE 2i, IPEndPoint=10.0.0.46:7000] because it isn't connected and hasn't been seen in 180s
01/18 08:55:07 Trace: [raat_ll/client] [AURALiC ARIES_MINI @ 10.0.0.47:46667] no data received for >10000ms. Killing connection.
01/18 08:55:07 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => Disconnected
01/18 08:55:07 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] lost client connection. Retrying
01/18 08:55:07 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] connecting (attempt 1)
01/18 08:55:07 Info: [transport] destroyed zone Headphones Auralic was playing? False
01/18 08:55:07 Trace: [zone Headphones Auralic] Suspend
01/18 08:55:07 Info: [zone Headphones Auralic] Canceling Pending Sleep
01/18 08:55:07 Info: [zone Headphones Auralic] Canceling Pending Sleep
01/18 08:55:07 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => Connecting
01/18 08:55:15 Debug: [easyhttp] [1735] POST to https://internetradio.roonlabs.net/2/api/reporting/internetradioplayback/plays?format=msgpack timed out after 60000 ms
01/18 08:55:17 Trace: [airplay] expired device AirPlayDevice[DeviceId=40CBC0DF8E8C@Apple TV._raop._tcp.local, Name=Apple-TV.local, Model=AppleTV6,2, IPEndPoint=10.0.0.42:7000] because it isn't connected and hasn't been seen in 180s
01/18 08:55:17 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => ConnectionFailed
01/18 08:55:17 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] client connection failed. Retrying in 500ms
01/18 08:55:18 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] connecting (attempt 2)
01/18 08:55:18 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => Connecting
01/18 08:55:28 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => ConnectionFailed
01/18 08:55:28 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] client connection failed. Retrying in 750ms
01/18 08:55:29 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] connecting (attempt 3)
01/18 08:55:29 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => Connecting
01/18 08:55:30 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 08:55:30 Trace: [push] request to manager failed
01/18 08:55:30 Trace: [push] retrying connection in 168444ms
01/18 08:55:39 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => ConnectionFailed
01/18 08:55:39 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] client connection failed. Retrying in 1125ms
01/18 08:55:40 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] connecting (attempt 4)
01/18 08:55:40 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => Connecting
01/18 08:55:41 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 08:55:41 Trace: [push] request to manager failed
01/18 08:55:41 Trace: [push] retrying connection in 258529ms
01/18 08:55:50 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => ConnectionFailed
01/18 08:55:50 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] client connection failed. Retrying in 1687ms
01/18 08:55:52 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] connecting (attempt 5)
01/18 08:55:52 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => Connecting
01/18 08:56:02 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => ConnectionFailed
01/18 08:56:02 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] client connection failed. Giving up
01/18 08:56:22 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 08:56:22 Trace: [push] request to manager failed
01/18 08:56:22 Trace: [push] retrying connection in 455776ms
01/18 08:57:55 Trace: [musicpowerstate] music has not been playing for 5 minutes, allowing idle sleep
01/18 08:58:24 Trace: [broker/accounts] [heartbeat] now=1/18/2021 4:58:24 PM nextauthrefresh=1/18/2021 5:48:25 PM nextmachineallocate=1/18/2021 8:48:24 PM
01/18 08:58:28 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 08:58:28 Trace: [push] request to manager failed
01/18 08:58:28 Trace: [push] retrying connection in 21956ms
01/18 08:59:00 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 08:59:00 Trace: [push] request to manager failed
01/18 08:59:00 Trace: [push] retrying connection in 196209ms
01/18 09:00:10 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 09:00:10 Trace: [push] request to manager failed
01/18 09:00:10 Trace: [push] retrying connection in 703965ms
01/18 09:02:26 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 09:02:26 Trace: [push] request to manager failed
01/18 09:02:26 Trace: [push] retrying connection in 850141ms
01/18 09:03:24 Trace: [broker/accounts] [heartbeat] now=1/18/2021 5:03:24 PM nextauthrefresh=1/18/2021 5:48:25 PM nextmachineallocate=1/18/2021 8:48:24 PM
01/18 09:04:07 Warn: Error in web request https://push.roonlabs.com/push/1/connect: NetworkError (The request was aborted: The request was canceled.)
01/18 09:04:07 Trace: [push] request to manager failed
01/18 09:04:07 Trace: [push] retrying connection in 773348ms
01/18 09:05:53 Trace: [raat] Endpoint discovered: Sooloos.Audio.Raat.DiscoveryData
01/18 09:05:53 Info: [raat] Initializing RoonReady Device
01/18 09:05:53 Info: [raat] Address: 10.0.0.47
01/18 09:05:53 Info: [raat] Port: 46667
01/18 09:05:53 Info: [raat] IsDev: False
01/18 09:05:53 Info: [raat] UniqueId: 7d81dd2e-a4ea-407a-a5c0-BC3400A036B5
01/18 09:05:53 Info: [raat] ProtocolVersion: 3
01/18 09:05:53 Info: [raat] Version: 7.2.1
01/18 09:05:53 Info: [raat] RaatVersion: 1.1.36
01/18 09:05:53 Info: [raat] Model: ARIES_MINI
01/18 09:05:53 Info: [raat] Vendor: AURALiC
01/18 09:05:53 Info: [raat] VendorModel: AURALiC ARIES_MINI
01/18 09:05:53 Info: [raat] Serial: 3LASOFOT
01/18 09:05:53 Info: [raat] OutputName:
01/18 09:05:53 Info: [raat] AutoName:
01/18 09:05:53 Info: [devicedb] [autodetect] Match DeviceAutodetectData[Type=RoonReady Vendor=AURALiC Model=ARIES_MINI] => AURALiC ARIES MINI
01/18 09:05:53 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] connecting (attempt 1)
01/18 09:05:53 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => Connecting
01/18 09:05:53 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] Initializing RAAT session
01/18 09:05:53 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] Loading script raat.dat:base.lua as module base [1088 chars]
01/18 09:05:53 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] Loading script raat.dat:dkjson.lua as module dkjson [22416 chars]
01/18 09:05:53 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] Loading script raat.dat:protocol.lua as module protocol [2045 chars]
01/18 09:05:53 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] Loading script raat.dat:roon_tcp.lua [43475 chars]
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] RAAT Session initialized in 50ms
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] SENT [2]{"request":"info"}
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] GOT [2] {"flags":{"has_write_chmap":true},"platform":{"os":"linux","uname":{"sysname":"Linux","release":"4.1.18-rt17","version":"#1 SMP PREEMPT RT Tue Oct 20 15:43:33 CST 2020","nodename":"auralic","machine":"armv7l"}},"volume":{"is_supported":false,"info":[]},"transport":{"info":{"config":{"type":"test"}},"is_update_status_supported":true,"is_supported":true,"is_update_artwork_supported":true},"status":"Success","info":{"unique_id":"7d81dd2e-a4ea-407a-a5c0-BC3400A036B5"},"source_selection":{"is_supported":true,"info":{"config":{"type":"test"}}},"output":{"info":{"config":{"dsd_mode":"dop_or_native","signal_path":[{"type":"output","quality":"lossless","method":"analog_digital"}],"device":"hw:0,0","resync_delay":2}},"supported_formats":"88200/16/1|2,48000/24/1|2,44100/24/1|2,176400/16/1|2,192000/24/1|2,44100/32/1|2,176400/32/1|2,44100/16/1|2,2822400/1/1|2,96000/24/1|2,176400/24/1|2,384000/24/1|2,384000/16/1|2,352800/32/1|2,96000/32/1|2,5644800/1/1|2,352800/16/1|2,88200/32/1|2,96000/16/1|2,48000/32/1|2,192000/32/1|2,192000/16/1|2,384000/32/1|2,88200/24/1|2,11289600/1/1|2,352800/24/1|2,48000/16/1|2"}}
01/18 09:05:54 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] => Connected
01/18 09:05:54 Trace: [raat] [AURALiC ARIES_MINI @ 10.0.0.47:46667] connected
01/18 09:05:54 Info: [transport] creating endpoint for raat device 7d81dd2e-a4ea-407a-a5c0-BC3400A036B5
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] SENT [4]{"request":"subscribe_transport"}
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"347a865d-a203-4d05-8654-2481b5153a2e"}
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] GOT [3] {"status":"Success"}
01/18 09:05:54 Trace: [dspengine] loaded DSP config {"version":3,"items":[{"type":"parametric_equalizer","enabled":true,"bands":[{"type":"equalize_frequency","frequency":72.8,"gain_db":3.87,"q":0.1,"is_enabled":true},{"type":"equalize_frequency","frequency":250,"gain_db":0,"q":1,"is_enabled":true},{"type":"equalize_frequency","frequency":1000,"gain_db":0,"q":1,"is_enabled":true},{"type":"equalize_frequency","frequency":4000,"gain_db":0,"q":1,"is_enabled":true},{"type":"equalize_frequency","frequency":8000,"gain_db":0,"q":1,"is_enabled":true}],"gain_db":0,"y_axis_min_db":-12,"y_axis_max_db":12},{"type":"bs2b","enabled":true,"preset":"meier","feed_level_db":9.5,"cut_frequency":650}],"headroom_adjustment":{"type":"headroom_adjustment","enable_clipping_indicator":true,"enabled":true,"gain_db":-3},"sample_rate_conversion":{"type":"sample_rate_conversion","enabled":true,"sample_rate_conversion_mode":"max_sample_rate","parallel_dsd_modulator":false,"sample_rate_custom_rules":[{"input_rate":44100,"output_rate":384000},{"input_rate":48000,"output_rate":384000},{"input_rate":88200,"output_rate":384000},{"input_rate":96000,"output_rate":384000},{"input_rate":176400,"output_rate":384000},{"input_rate":192000,"output_rate":384000},{"input_rate":352800,"output_rate":384000},{"input_rate":2822400,"output_rate":11289600},{"input_rate":5644800,"output_rate":11289600},{"input_rate":11289600,"output_rate":11289600},{"input_rate":22579200,"output_rate":11289600}],"src_filter_type":"minimum_phase_smooth","allow_dsd_processing":true,"dsd_output_rate":11289600,"dsd_modulator":"clans_order7"},"is_enabled":true}
01/18 09:05:54 Trace: [zone Headphones Auralic] Loading
01/18 09:05:54 Trace: [zone Headphones Auralic] Suspend
01/18 09:05:54 Info: [zone Headphones Auralic] Canceling Pending Sleep
01/18 09:05:54 Trace: [Headphones Auralic] [zoneplayer/raat] Endpoint AURALiC ARIES_MINI Initial State: Idle
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] GOT [5] {"status":"Success","controls":{"source":{"info":{"config":{"type":"test"}},"value":"standby"}},"action":"Changed"}
01/18 09:05:54 Info: [transport] created zone Headphones Auralic
01/18 09:05:54 Info: [transport] with endpoint AURALiC ARIES_MINI (23:1:7d81dd2e-a4ea-407a-a5c0-bc3400a036b5) [IsAvailable=True]
01/18 09:05:54 Trace: [Headphones Auralic] [Inactive] [STOPPED @ 0:00]
01/18 09:05:54 Trace: [Headphones Auralic] [Inactive] [PAUSED @ 0:02/4:00] Leaving of Liverpool - Shane McGowan / Shane MacGowan / Johnny Depp / Gore Verbinski
01/18 09:05:54 Trace: [dbperf] flush 0 bytes, 0 ops in 7 ms (cumulative 114337815 bytes, 59517 ops in 155806 ms)
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] SENT [8]{"request":"update_artwork","mimetype":"image/jpeg"}
01/18 09:05:54 Trace: [AURALiC ARIES_MINI @ 10.0.0.47:46667] [raatclient] GOT [8] {"status":"Success"}
01/18 09:05:54 Trace: [dbperf] flush 0 bytes, 0 ops in 8 ms (cumulative 114337815 bytes, 59517 ops in 155814 ms)
01/18 09:06:04 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
01/18 09:06:04 Trace: [push] connecting to 34.74.254.52:9200
01/18 09:06:11 Trace: [devicedb] [autodetect] No Match for DeviceAutodetectData[Type=AirPlay Model=POWERNODE 2i DescriptiveName=BS Bedroom]
01/18 09:06:16 Trace: [raat] Endpoint discovered: Sooloos.Audio.Raat.DiscoveryData
01/18 09:06:16 Info: [raat] Initializing RoonReady Device
01/18 09:06:16 Info: [raat] Address: 10.0.0.46
01/18 09:06:16 Info: [raat] Port: 35471
01/18 09:06:16 Info: [raat] IsDev: False
01/18 09:06:16 Info: [raat] UniqueId: BluOS:90:56:82:7f:a5:bb
01/18 09:06:16 Info: [raat] ProtocolVersion: 3
01/18 09:06:16 Info: [raat] Version: 3.12.13
01/18 09:06:16 Info: [raat] RaatVersion: 1.1.36
01/18 09:06:16 Info: [raat] Model: POWERNODE 2i
01/18 09:06:16 Info: [raat] Vendor: Bluesound
01/18 09:06:16 Info: [raat] VendorModel: Bluesound POWERNODE 2i
01/18 09:06:16 Info: [raat] Serial:
01/18 09:06:16 Info: [raat] OutputName:
01/18 09:06:16 Info: [raat] AutoName: BS Bedroom
01/18 09:06:16 Info: [devicedb] [autodetect] Match DeviceAutodetectData[Type=RoonReady Vendor=Bluesound Model=POWERNODE 2i] => Bluesound POWERNODE 2i
01/18 09:06:16 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] connecting (attempt 1)
01/18 09:06:16 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => Connecting
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] Initializing RAAT session
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] Loading script raat.dat:base.lua as module base [1088 chars]
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] Loading script raat.dat:dkjson.lua as module dkjson [22416 chars]
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] Loading script raat.dat:protocol.lua as module protocol [2045 chars]
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] Loading script raat.dat:roon_tcp.lua [43475 chars]
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] RAAT Session initialized in 117ms
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] SENT [2]{"request":"info"}
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [2] {"flags":{"has_write_chmap":true},"source_selection":{"is_supported":true,"info":{}},"volume":{"is_supported":true,"info":{}},"info":{"unique_id":"BluOS:90:56:82:7f:a5:bb"},"transport":{"is_update_status_supported":true,"is_update_artwork_supported":true,"is_supported":true,"info":{}},"platform":{"uname":{"sysname":"Linux","version":"#1 SMP Wed Oct 21 12:02:41 EDT 2020","nodename":"BSBedroom","machine":"armv7l","release":"5.7.0-00894-g594b7dcc08fa"},"os":"linux"},"status":"Success","output":{"info":{"mqa_capabilities":["renderer","decoder"]},"supported_formats":"24000/16/2,32000/16/2,96000/16/2,96000/24/2,48000/16/2,32000/24/2,88200/24/2,44100/16/2,22050/24/2,24000/24/2,192000/16/2,88200/16/2,192000/24/2,22050/16/2,176400/24/2,176400/16/2,48000/24/2,44100/24/2"}}
01/18 09:06:16 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] => Connected
01/18 09:06:16 Trace: [raat] [Bluesound POWERNODE 2i @ 10.0.0.46:35471] connected
01/18 09:06:16 Info: [transport] creating endpoint for raat device BluOS:90:56:82:7f:a5:bb
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] SENT [4]{"request":"subscribe_transport"}
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"347a865d-a203-4d05-8654-2481b5153a2e"}
01/18 09:06:16 Trace: [dspengine] loaded DSP config {"version":3,"items":[{"type":"bs2b","enabled":false},{"type":"parametric_equalizer","enabled":false},{"type":"audeze_presets","enabled":false}],"headroom_adjustment":{"type":"headroom_adjustment","enabled":true,"enable_clipping_indicator":true,"gain_db":0},"sample_rate_conversion":{"type":"sample_rate_conversion","enabled":true,"sample_rate_conversion_mode":"max_sample_rate","src_filter_type":"linear_phase"}}
01/18 09:06:16 Trace: [transport/audeze] picking preset lowlatency
01/18 09:06:16 Trace: [transport/audeze] picked null preset!
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [3] {"status":"Success"}
01/18 09:06:16 Trace: [zone Master Bedroom] Loading
01/18 09:06:16 Trace: [Bluesound POWERNODE 2i @ 10.0.0.46:35471] [raatclient] GOT [5] {"controls":{"volume":{"type":"number","step":1.0,"min":0.0,"value":0,"info":{},"mute":false,"max":100.0},"source":{"value":"not_selected","info":{}}},"status":"Success","action":"Changed"}
01/18 09:06:16 Trace: [zone Master Bedroom] Suspend
01/18 09:06:16 Info: [zone Master Bedroom] Canceling Pending Sleep
01/18 09:06:16 Trace: [Master Bedroom] [zoneplayer/raat] Endpoint Bluesound POWERNODE 2i Initial State: Idle
01/18 09:06:16 Info: [transport] created zone Master Bedroom
01/18 09:06:16 Info: [transport] with endpoint Bluesound POWERNODE 2i (23:1:8afa9a18-dd87-4c76-5829-f9890fdb0e6b) [IsAvailable=True]
01/18 09:06:16 Info: [zone Master Bedroom] Canceling Pending Sleep