>>> /Users/jason/Library/RoonServer/Cache/smc.db/bfc/539.cache
>>> https://streaming-qobuz-std.akamaized.net/file
03/26 09:41:42 Debug: FTMSI-B Cache open file qo/319336CB domain: zoneplayer:1147 ordinal:2
03/26 09:41:42 Debug: FTMSI-B qo/319336CB download status: DownloadNotStarted accessTimeout:False openFiles:1 prev:no
03/26 09:41:42 Trace: [roondns] flushed 46 last-known-good entries
03/26 09:41:43 Debug: [easyhttp] [24627] GET to https://streaming-qobuz-std.akamaized.net/file?uid=1877161&eid=2006635&fmt=6&profile=raw&app_id=188245549&cid=1298357&etsp=1711464102&hmac=9S2ABInFq38u_jL5RxPJ-z-mFyo returned after 1094 ms, status code: 200, request body size: 0 B
03/26 09:41:43 Debug: FTMSI-B got length for qo/F3A7532C; 36.3 MBytes
03/26 09:41:43 Debug: FTMSI-B qo/F3A7532C download status: FileLengthRetrieved accessTimeout:True openFiles:1 prev:(DownloadNotStarted,False,1)
03/26 09:41:43 Debug: FTMSI-B-OE set min bandwidth for qo/F3A7532C to 1058 kbps
03/26 09:41:43 Info: FTMSI-B-OE qo/F3A7532C rid:1 response took 1096ms
03/26 09:41:43 Debug: FTMSI-B qo/F3A7532C download status: FirstBlockRetrieved accessTimeout:False openFiles:1 prev:(FileLengthRetrieved,True,1)
03/26 09:41:44 Info: [Library Evo 150] [zoneplayer]     Open Result (Playing):Result[Status=Success]
03/26 09:41:44 Info: [Library Evo 150] [zoneplayer] Starting playback
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] StartStream Sooloos.Broker.Transport.RaatZonePlayer+Endpoint: StreamFormat(channels=2, bitspersample=16, samplerate=44100, isdts=False) => StreamFormat(channels=2, bitspersample=16, samplerate=44100, isdts=False) streamid=1729909341
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] SENT [15]{"request":"setup","format":{"sample_type":"pcm","sample_rate":44100,"bits_per_sample":16,"channels":2,"sample_subtype":"none"}}
03/26 09:41:44 Info: [zone Library Evo 150] OnPlayFeedback Playing
03/26 09:41:44 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:00] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [15] {"status":"OutputMessage","message":{"signal_path":[{"type":"amplifier","quality":"lossless","method":"analog"},{"type":"output","quality":"lossless","method":"speakers"}]}}
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [15] {"status":"OutputMessage","message":{"signal_path":[{"type":"eq","gain":1,"quality":"enhanced","sub_type":"bass"},{"type":"eq","gain":3,"quality":"enhanced","sub_type":"treble"},{"type":"amplifier","quality":"lossless","method":"analog"},{"type":"output","quality":"lossless","method":"speakers"}]}}
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [15] {"status":"OutputMessage","message":{"signal_path":[{"type":"eq","gain":1,"quality":"enhanced","sub_type":"bass"},{"type":"eq","gain":3,"quality":"enhanced","sub_type":"treble"},{"type":"amplifier","quality":"lossless","method":"analog"},{"type":"output","quality":"lossless","method":"speakers"}]}}
03/26 09:41:44 Trace: [prebuffer] ready 149940/441000 (34%) @ 0/337 sec
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [15] {"status":"Success","clock_port":52816,"audio_port":0,"audio_port_tcp":34881}
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] Endpoint Cambridge Audio Evo 150 State Changed: Idle => Prepared
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] synced to endpoint Cambridge Audio Evo 150 clock: realtime=785897569887 rtt=500us offset=259160569us delta=259160569us
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] SENT [17]{"request":"stream","stream_id":1729909341,"first_seq":-1,"nak_port":-1,"buffer_size":10,"ready_threshold":0.2}
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [17] {"status":"Buffering"}
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] Endpoint Cambridge Audio Evo 150 State Changed: Prepared => Buffering
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] [zoneplayer/raat] selected Cambridge Audio Evo 150 as clock master
03/26 09:41:44 Debug: [raat/tcpaudiosource] connecting to 10.0.1.2:34881
03/26 09:41:44 Debug: [raat/tcpaudiosource] connected
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [17] {"status":"Ready"}
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] Endpoint Cambridge Audio Evo 150 State Changed: Buffering => Ready
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] wait for ready in 41ms
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] Adjusting playback start offset from 50ms to 205ms
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] Doing 'ASAP' Start since we are just playing to one device
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] SENT [18]{"request":"start","min_offset":205294784,"stream_sample":0}
03/26 09:41:44 Trace: [Library Evo 150] [zoneplayer/raat] Endpoint Cambridge Audio Evo 150 State Changed: Ready => Playing
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [17] {"status":"Playing"}
03/26 09:41:44 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [18] {"status":"Success","time":786173057055}
03/26 09:41:44 Info: 
--[ SignalPath ]---------------------------------------------
SignalPath Quality = Enhanced
Elements:
    Source Format=Flac 44100/16/2  Quality=Lossless
    Raat Device=Cambridge Audio Evo 150
    EQ Subtype=bass Gain=1 Quality=Enhanced
    EQ Subtype=treble Gain=3 Quality=Enhanced
    Amplifier Method=analog Quality=Lossless
    Output OutputType=Local_Speakers Quality=Lossless SubType= Model=
------------------------------------------------------------
03/26 09:41:45 Debug: [easyhttp] [24628] POST to https://www.qobuz.com/api.json/0.2/track/reportStreamingStart? returned after 1263 ms, status code: 201, request body size: 358 B
03/26 09:41:46 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='Checking' HasChangeLog=False CurrentVersion={ MachineValue=200001388 DisplayValue='2.0 (build 1388) production' Branch='production' } }
03/26 09:41:46 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='Checking' HasChangeLog=False CurrentVersion={ MachineValue=200001388 DisplayValue='2.0 (build 1388) production' Branch='production' } }
03/26 09:41:46 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='Checking' HasChangeLog=False CurrentVersion={ MachineValue=200001388 DisplayValue='2.0 (build 1388) production' Branch='production' } }
03/26 09:41:46 Debug: [base/updater] Checking for updates: https://updates.roonlabs.net/update/?v=2&serial=1E476B0A-6CE9-4862-9F59-3FE335E8A29D&userid=324e013f-cbcc-4174-b662-15e1932c6442&platform=macosx&product=RoonServer&branding=roon&curbranch=production&version=200001388&branch=production&coredeviceid=27250a6d-660b-458b-af45-9e8967d8beef&deviceid=27250a6d-660b-458b-af45-9e8967d8beef&osversion=Mac+OS+X+14.2.1&os64bit=true
03/26 09:41:46 Debug: [easyhttp] [24629] GET to https://api.roonlabs.net/updates/update/?v=2&serial=1E476B0A-6CE9-4862-9F59-3FE335E8A29D&userid=324e013f-cbcc-4174-b662-15e1932c6442&platform=macosx&product=RoonServer&branding=roon&curbranch=production&version=200001388&branch=production&coredeviceid=27250a6d-660b-458b-af45-9e8967d8beef&deviceid=27250a6d-660b-458b-af45-9e8967d8beef&osversion=Mac+OS+X+14.2.1&os64bit=true returned after 357 ms, status code: 204, request body size: 0 B
03/26 09:41:46 Debug: [appupdater] Update not needed
03/26 09:41:46 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=200001388 DisplayValue='2.0 (build 1388) production' Branch='production' } }
03/26 09:41:46 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=200001388 DisplayValue='2.0 (build 1388) production' Branch='production' } }
03/26 09:41:46 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status='UpToDate' HasChangeLog=False CurrentVersion={ MachineValue=200001388 DisplayValue='2.0 (build 1388) production' Branch='production' } }
03/26 09:41:47 Debug: [easyhttp] [24630] POST to https://api.roonlabs.net/roonmobile/1/cores/announce returned after 591 ms, status code: 200, request body size: 906 B
03/26 09:41:47 Debug: [easyhttp] [24632] POST to https://api.roonlabs.net/roonmobile/1/cores/announce returned after 263 ms, status code: 200, request body size: 906 B
03/26 09:41:47 Debug: [easyhttp] [24631] POST to https://api.roonlabs.net/device-map/1/register returned after 586 ms, status code: 200, request body size: 9 KB
03/26 09:41:47 Trace: [devicemap] device map updated
03/26 09:41:47 Info: [library] saved recent ProfileId=ff7900a6-03f9-42dc-b391-5bda6b0d39e7 Time=3/26/2024 1:41:48PM DataType=album Type=long_nav MetadataId=1867129 ContentId=1867129 LibraryId=1033007 Text= Genre=
03/26 09:41:49 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:04/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:41:50 Info: [stats] 415762mb Virtual, 5941mb Physical, 5550mb Managed
03/26 09:41:54 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:09/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:00 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:15/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:00 Debug: FTMSI-B-OE qo/F3A7532C exit thread signalled
03/26 09:42:00 Debug: FTMSI-B qo/F3A7532C download status: AllBlocksDownloaded accessTimeout:False openFiles:1 prev:(FirstBlockRetrieved,False,1)
03/26 09:42:00 Info: FTMSI-B qo/F3A7532C: allocated bw changed from 51200 to 0 kbps
03/26 09:42:00 Info: FTMSI-B qo/319336CB: allocated bw changed from 0 to 51200 kbps
03/26 09:42:00 Info: FTMSI-B 1 FileCache qo/0B6B6DC0 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':64) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 2 FileCache qo/7B9B6122 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':158) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 3 FileCache qo/859E3976 dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':427) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 4 FileCache qo/759DC874 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':167) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 5 FileCache qo/2429A3BB dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':426) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 6 FileCache qo/7EFBA6CC dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':14) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 7 FileCache qo/3E790878 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':15) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 8 FileCache qo/186F526F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':26) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 9 FileCache qo/445AF3C6 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':27) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 10 FileCache qo/9C05F139 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':157) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 11 FileCache qo/1C2FF268 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':65) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 12 FileCache qo/D2C5A425 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':97) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 13 FileCache qo/DB3CBB0F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':168) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 14 FileCache qo/DC8B5663 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':98) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 15 FileCache qo/55868676 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':16) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 16 FileCache qo/7AC758F8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':13) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 17 FileCache qo/3B73CE7D dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':15) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 18 FileCache qo/DF3F96EF dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':14) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 19 FileCache qo/ACDD6D17 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':16) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 20 FileCache qo/1BDD2F3A dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':17) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 21 FileCache qo/D5322EC1 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':7) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 22 FileCache qo/5989A706 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':8) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 23 FileCache qo/84CA9F48 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':13) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 24 FileCache qo/FC5470B3 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':14) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 25 FileCache qo/4A7922A4 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':4) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 26 FileCache qo/102C670F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':14) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 27 FileCache qo/74F96FDD dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':15) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 28 FileCache qo/5157E526 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':5) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 29 FileCache qo/E0CFEDE8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1136':4) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 30 FileCache qo/74A88F5F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':20) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 31 FileCache qo/B49ADAE9 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':21) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 32 FileCache qo/926B209F dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:1136':5) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 33 FileCache qo/F3A7532C dwStatus:AllBlocksDownloaded files:1 accessTimeOut:False priorities: ('zoneplayer:1147':1) --> bw limit:0kbps
03/26 09:42:00 Info: FTMSI-B 34 FileCache qo/319336CB dwStatus:DownloadNotStarted files:1 accessTimeOut:True priorities: ('zoneplayer:1147':2) --> bw limit:51200kbps
03/26 09:42:00 Debug: FTMSI-B-OE qo/319336CB created new req 1 for block 0 p 4294967295; active requests 1
03/26 09:42:00 Debug: FTMSI-B-OE qo/F3A7532C rid:1 interrupt requested; reason: exit
03/26 09:42:00 Debug: FTMSI-B-OE qo/F3A7532C rid:1 request ended -- first block: 0 blocks read: 1161 download speed: 17661kbps response time: 1096ms
03/26 09:42:01 Debug: [easyhttp] [24633] GET to https://streaming-qobuz-std.akamaized.net/file?uid=1877161&eid=2006636&fmt=6&profile=raw&app_id=188245549&cid=1298357&etsp=1711464102&hmac=YBzGrHFaYdJV-7dA4Efq8f1sJgQ returned after 997 ms, status code: 200, request body size: 0 B
03/26 09:42:01 Debug: FTMSI-B got length for qo/319336CB; 41.6 MBytes
03/26 09:42:01 Debug: FTMSI-B qo/319336CB download status: FileLengthRetrieved accessTimeout:True openFiles:1 prev:(DownloadNotStarted,True,1)
03/26 09:42:01 Debug: FTMSI-B-OE set min bandwidth for qo/319336CB to 980 kbps
03/26 09:42:01 Info: FTMSI-B-OE qo/319336CB rid:1 response took 999ms
03/26 09:42:01 Debug: FTMSI-B qo/319336CB download status: FirstBlockRetrieved accessTimeout:False openFiles:1 prev:(FileLengthRetrieved,True,1)
03/26 09:42:01 Info: [Library Evo 150] [zoneplayer] Open result (Queueing): Result[Status=Success]
03/26 09:42:02 Debug: FTMSI-B qo/319336CB download status: FirstBlockRetrieved accessTimeout:True openFiles:1 prev:(FirstBlockRetrieved,False,1)
03/26 09:42:05 Info: [stats] 415703mb Virtual, 5684mb Physical, 5553mb Managed
03/26 09:42:05 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:20/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:10 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:25/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:15 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=816340705967 rtt=500us offset=259159705us delta=-206us drift=-863us in 30.444s (-28.377ppm, -102.158ms/hr)
03/26 09:42:15 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:30/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:19 Info: [library/albumdetails] found 1 ingroup alternates, 0 other alternates
03/26 09:42:19 Info: [library/albumdetails] Created album details screen for LibraryAlbum[1033007, Yellowjackets - Blue Hats]
03/26 09:42:19 Info: [library/albumdetails] 79004d5730303030363136353436, 79004d5230303033383837353135, 3e0121e1f4a126d4d04cafc725fcbac1a0c7, 3e015fcd93d5136c184f98bf188ab41dae13, a60033343632383637, c80030303933363234363333333635, cd0050596f6675527157716e735f513631676f43, cd0035596c5069427048734c7050796246697251
03/26 09:42:19 Trace: [music/query] performing album query
03/26 09:42:19 Warn: null SortEnv language. Defaulting to current culture.
03/26 09:42:19 Trace: [music/query] query returned 12 Sooloos.Broker.Api.AlbumLite(s)
03/26 09:42:19 Trace: [music/query] performing album query
03/26 09:42:19 Warn: null SortEnv language. Defaulting to current culture.
03/26 09:42:19 Trace: [music/query] query returned 0 Sooloos.Broker.Api.AlbumLite(s)
03/26 09:42:19 Debug: [easyhttp] [24641] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=121:0:MW0000616546&type=review&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-us&tidal=max returned after 179 ms, status code: 200, request body size: 0 B
03/26 09:42:19 Debug: [easyhttp] [24637] GET to https://api.roonlabs.net/discover/1/albums/121:0:MW0000616546/albums/morefromcollaborators?profileId=ff7900a6-03f9-42dc-b391-5bda6b0d39e7&c=qobuz-us&tidal=max returned after 219 ms, status code: 404
03/26 09:42:19 Debug: [easyhttp] [24636] GET to https://api.roonlabs.net/discover/1/albums/121:0:MW0000616546/timeline/albums?profileId=ff7900a6-03f9-42dc-b391-5bda6b0d39e7&c=qobuz-us&tidal=max returned after 314 ms, status code: 200, request body size: 0 B
03/26 09:42:19 Debug: [easyhttp] [24642] GET to https://api.roonlabs.net/discover/1/albums/121:0:MW0000616546/recommended/albums?profileId=ff7900a6-03f9-42dc-b391-5bda6b0d39e7&c=qobuz-us&tidal=max returned after 317 ms, status code: 200, request body size: 0 B
03/26 09:42:19 Debug: [easyhttp] [24639] GET to https://api.roonlabs.net/discover/1/albums/121:0:MW0000616546/performers/similar?profileId=ff7900a6-03f9-42dc-b391-5bda6b0d39e7&c=qobuz-us&languages=en,%3Een&tidal=max returned after 355 ms, status code: 200, request body size: 0 B
03/26 09:42:19 Debug: [easyhttp] [24634] POST to https://api.roonlabs.net/browse/1/works/trackCounts?c=qobuz-us&tidal=max returned after 448 ms, status code: 200, request body size: 149 B
03/26 09:42:19 Debug: [easyhttp] [24638] GET to https://api.roonlabs.net/discover/1/albums/121:0:MW0000616546/similar/albums?profileId=ff7900a6-03f9-42dc-b391-5bda6b0d39e7&c=qobuz-us&tidal=max returned after 460 ms, status code: 200, request body size: 0 B
03/26 09:42:19 Debug: [easyhttp] [24635] GET to https://api.roonlabs.net/discover/1/albums/121:0:MW0000616546/albums/new?profile=ff7900a6-03f9-42dc-b391-5bda6b0d39e7&c=qobuz-us&tidal=max returned after 558 ms, status code: 200, request body size: 0 B
03/26 09:42:20 Info: [stats] 415705mb Virtual, 5620mb Physical, 5560mb Managed
03/26 09:42:20 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:35/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:21 Debug: [easyhttp] [24640] GET to https://api.roonlabs.net/discover/1/albums/121:0:MW0000616546/albums/morefromgenre?profileId=ff7900a6-03f9-42dc-b391-5bda6b0d39e7&c=qobuz-us&tidal=max returned after 2358 ms, status code: 200, request body size: 0 B
03/26 09:42:23 Debug: FTMSI-B-OE qo/319336CB exit thread signalled
03/26 09:42:23 Debug: FTMSI-B qo/319336CB download status: AllBlocksDownloaded accessTimeout:True openFiles:1 prev:(FirstBlockRetrieved,True,1)
03/26 09:42:23 Info: FTMSI-B qo/319336CB: allocated bw changed from 51200 to 0 kbps
03/26 09:42:23 Info: FTMSI-B 1 FileCache qo/0B6B6DC0 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':64) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 2 FileCache qo/7B9B6122 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':158) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 3 FileCache qo/859E3976 dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':427) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 4 FileCache qo/759DC874 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':167) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 5 FileCache qo/2429A3BB dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':426) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 6 FileCache qo/7EFBA6CC dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':14) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 7 FileCache qo/3E790878 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':15) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 8 FileCache qo/186F526F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':26) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 9 FileCache qo/445AF3C6 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':27) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 10 FileCache qo/9C05F139 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':157) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 11 FileCache qo/1C2FF268 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':65) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 12 FileCache qo/D2C5A425 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':97) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 13 FileCache qo/DB3CBB0F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':168) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 14 FileCache qo/DC8B5663 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':98) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 15 FileCache qo/55868676 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':16) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 16 FileCache qo/7AC758F8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':13) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 17 FileCache qo/3B73CE7D dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':15) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 18 FileCache qo/DF3F96EF dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':14) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 19 FileCache qo/ACDD6D17 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':16) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 20 FileCache qo/1BDD2F3A dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':17) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 21 FileCache qo/D5322EC1 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':7) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 22 FileCache qo/5989A706 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':8) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 23 FileCache qo/84CA9F48 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':13) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 24 FileCache qo/FC5470B3 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':14) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 25 FileCache qo/4A7922A4 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':4) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 26 FileCache qo/102C670F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':14) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 27 FileCache qo/74F96FDD dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':15) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 28 FileCache qo/5157E526 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':5) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 29 FileCache qo/E0CFEDE8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1136':4) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 30 FileCache qo/74A88F5F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':20) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 31 FileCache qo/B49ADAE9 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':21) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 32 FileCache qo/926B209F dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:1136':5) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 33 FileCache qo/F3A7532C dwStatus:AllBlocksDownloaded files:1 accessTimeOut:False priorities: ('zoneplayer:1147':1) --> bw limit:0kbps
03/26 09:42:23 Info: FTMSI-B 34 FileCache qo/319336CB dwStatus:AllBlocksDownloaded files:1 accessTimeOut:True priorities: ('zoneplayer:1147':2) --> bw limit:0kbps
03/26 09:42:23 Debug: FTMSI-B-OE qo/319336CB rid:1 request ended -- first block: 0 blocks read: 1332 download speed: 15591kbps response time: 999ms
03/26 09:42:23 Info: [remoting/serverconnectionv2] Client disconnected: 10.0.1.160:53180
03/26 09:42:23 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] lost client connection. Retrying
03/26 09:42:23 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] connecting (attempt 1)
03/26 09:42:23 Warn: [rnet/RnetJsonClient] failed to connect Connection refused
03/26 09:42:23 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] client connection failed. Retrying in 500ms
03/26 09:42:24 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] connecting (attempt 2)
03/26 09:42:24 Warn: [rnet/RnetJsonClient] failed to connect Connection refused
03/26 09:42:24 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] client connection failed. Retrying in 750ms
03/26 09:42:25 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] connecting (attempt 3)
03/26 09:42:25 Warn: [rnet/RnetJsonClient] failed to connect Connection refused
03/26 09:42:25 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] client connection failed. Retrying in 1125ms
03/26 09:42:25 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:40/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:26 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] connecting (attempt 4)
03/26 09:42:26 Warn: [rnet/RnetJsonClient] failed to connect Connection refused
03/26 09:42:26 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] client connection failed. Retrying in 1687ms
03/26 09:42:28 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] connecting (attempt 5)
03/26 09:42:28 Warn: [rnet/RnetJsonClient] failed to connect Connection refused
03/26 09:42:28 Trace: [raatserver] [RaatServer localhost @ 10.0.1.160:9200] client connection failed. Giving up
03/26 09:42:28 Trace: [raat] [sood] Refreshing device list
03/26 09:42:30 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:45/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:35 Info: [stats] 415715mb Virtual, 4922mb Physical, 5564mb Managed
03/26 09:42:36 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:51/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:38 Debug: [easyhttp] [24643] POST to https://api.roonlabs.net/device-map/1/register returned after 445 ms, status code: 200, request body size: 9 KB
03/26 09:42:38 Trace: [devicemap] device map updated
03/26 09:42:41 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:56/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:45 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=846967765636 rtt=1000us offset=259158765us delta=-265us drift=-1804us in 61.072s (-29.543ppm, -106.355ms/hr)
03/26 09:42:46 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:01/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:50 Info: [stats] 415702mb Virtual, 4925mb Physical, 5561mb Managed
03/26 09:42:52 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:07/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:42:57 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:12/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:02 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:17/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:05 Info: [stats] 415702mb Virtual, 4926mb Physical, 5563mb Managed
03/26 09:43:07 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:22/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:12 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:27/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:16 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=877408916362 rtt=500us offset=259157916us delta=331us drift=-2653us in 91.514s (-28.996ppm, -104.385ms/hr)
03/26 09:43:17 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:32/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:20 Info: [stats] 415703mb Virtual, 5144mb Physical, 5564mb Managed
03/26 09:43:22 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:37/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:27 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:42/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:32 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:47/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:35 Info: [stats] 415703mb Virtual, 5739mb Physical, 5523mb Managed
03/26 09:43:38 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:53/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:43 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 1:58/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:46 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=907879761457 rtt=500us offset=259156761us delta=-250us drift=-3808us in 121.986s (-31.220ppm, -112.393ms/hr)
03/26 09:43:48 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:04/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:50 Info: [stats] 415702mb Virtual, 5639mb Physical, 5523mb Managed
03/26 09:43:53 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:09/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:43:59 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:14/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:04 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:19/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:05 Info: [stats] 415702mb Virtual, 5445mb Physical, 5524mb Managed
03/26 09:44:09 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:23/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:14 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:29/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:17 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=938406522426 rtt=1000us offset=259156522us delta=27us drift=-4047us in 152.513s (-26.538ppm, -95.538ms/hr)
03/26 09:44:19 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:34/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:20 Info: [stats] 415704mb Virtual, 5326mb Physical, 5524mb Managed
03/26 09:44:22 Trace: [broker/accounts] [heartbeat] now=3/26/2024 1:44:22PM nextauthrefresh=3/26/2024 2:39:23PM nextmachineallocate=3/26/2024 5:39:22PM
03/26 09:44:24 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:39/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:30 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:45/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:35 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:50/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:35 Info: [stats] 415702mb Virtual, 5307mb Physical, 5527mb Managed
03/26 09:44:40 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 2:55/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:45 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:00/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:47 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=968918207169 rtt=500us offset=259155207us delta=510us drift=-5362us in 183.0255s (-29.300ppm, -105.481ms/hr)
03/26 09:44:50 Info: [stats] 415702mb Virtual, 5263mb Physical, 5527mb Managed
03/26 09:44:50 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:05/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:44:55 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:10/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:01 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:16/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:05 Info: [stats] 415702mb Virtual, 5147mb Physical, 5528mb Managed
03/26 09:45:06 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:21/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:11 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:26/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:16 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:31/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:18 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=999345989733 rtt=500us offset=259153989us delta=274us drift=-6580us in 213.455s (-30.827ppm, -110.977ms/hr)
03/26 09:45:20 Info: [stats] 415703mb Virtual, 5972mb Physical, 5522mb Managed
03/26 09:45:21 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:36/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:26 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:41/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:31 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:46/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:35 Info: [stats] 415703mb Virtual, 5640mb Physical, 5522mb Managed
03/26 09:45:37 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:52/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:42 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 3:57/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:47 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:02/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:48 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=1029684027240 rtt=500us offset=259153027us delta=2us drift=-7542us in 243.7945s (-30.939ppm, -111.379ms/hr)
03/26 09:45:50 Info: [stats] 415702mb Virtual, 5606mb Physical, 5523mb Managed
03/26 09:45:53 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:07/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:45:58 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:13/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:03 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:18/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:05 Info: [stats] 415702mb Virtual, 5573mb Physical, 5524mb Managed
03/26 09:46:08 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:23/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:14 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:29/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:18 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=1060028030918 rtt=1000us offset=259152030us delta=-105us drift=-8538us in 274.139s (-31.148ppm, -112.134ms/hr)
03/26 09:46:19 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:34/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:20 Info: [stats] 415702mb Virtual, 5576mb Physical, 5523mb Managed
03/26 09:46:24 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:39/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:29 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:44/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:35 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:50/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:35 Info: [stats] 415704mb Virtual, 5533mb Physical, 5523mb Managed
03/26 09:46:40 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 4:55/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:45 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 5:00/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:49 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=1090341130517 rtt=500us offset=259151130us delta=-305us drift=-9439us in 304.4535s (-31.004ppm, -111.616ms/hr)
03/26 09:46:50 Info: [stats] 415702mb Virtual, 5535mb Physical, 5524mb Managed
03/26 09:46:50 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 5:05/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:46:55 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 5:10/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:47:00 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 5:15/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:47:05 Info: [stats] 415702mb Virtual, 5535mb Physical, 5525mb Managed
03/26 09:47:05 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 5:20/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:47:06 Trace: [prebuffer] short read: 0 / 8820 fill=440136
03/26 09:47:10 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [65% buf] [PLAYING @ 5:26/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:47:16 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [11% buf] [PLAYING @ 5:30/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:47:16 Trace: [prebuffer] ready 149940/441000 (34%) @ 0/417 sec
03/26 09:47:19 Trace: [Library Evo 150] [zoneplayer/raat] sync Cambridge Audio Evo 150: realtime=1120777173665 rtt=500us offset=259150173us delta=31us drift=-10396us in 334.89s (-31.044ppm, -111.757ms/hr)
03/26 09:47:20 Info: [stats] 415703mb Virtual, 6165mb Physical, 5523mb Managed
03/26 09:47:21 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [3% buf] [PLAYING @ 5:36/5:37] CapeTown (Album Version) - Yellowjackets / Jimmy Haslip / Russell Ferrante / William Kennedy
03/26 09:47:21 Trace: [library] endmutation in 28ms
03/26 09:47:22 Debug: FTMSI-B closed file for qo/F3A7532C; open files:0
03/26 09:47:22 Debug: FTMSI-B qo/F3A7532C download status: AllBlocksDownloaded accessTimeout:True openFiles:0 prev:(AllBlocksDownloaded,False,1)
03/26 09:47:22 Info: 
--[ SignalPath ]---------------------------------------------
SignalPath Quality = Enhanced
Elements:
    Source Format=Flac 44100/16/2  Quality=Lossless
    Raat Device=Cambridge Audio Evo 150
    EQ Subtype=bass Gain=1 Quality=Enhanced
    EQ Subtype=treble Gain=3 Quality=Enhanced
    Amplifier Method=analog Quality=Lossless
    Output OutputType=Local_Speakers Quality=Lossless SubType= Model=
------------------------------------------------------------
03/26 09:47:22 Info: [library] recorded play for profile ff7900a6-03f9-42dc-b391-5bda6b0d39e7: mediaid=50:1:71dfa4ac-6a3b-4baa-9244-98f6ab1c26c6 metadataid= contentid=202:0:2006635 libraryid=50:1:71dfa4ac-6a3b-4baa-9244-98f6ab1c26c6 isfromradio=False isfrommix=False isfrommobile=
03/26 09:47:22 Info: [zone Library Evo 150] OnPlayFeedback OnToNext
03/26 09:47:22 Debug: [zone Library Evo 150] _Advance (Track)
03/26 09:47:22 Info: [zone Library Evo 150] OnPlayFeedback Playing
03/26 09:47:22 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [15] {"status":"OutputMessage","message":{"signal_path":[{"type":"eq","gain":1,"quality":"enhanced","sub_type":"bass"},{"type":"eq","gain":3,"quality":"enhanced","sub_type":"treble"},{"type":"amplifier","quality":"lossless","method":"analog"},{"type":"output","quality":"lossless","method":"speakers"}]}}
03/26 09:47:22 Trace: [library] finished with 120 dirty tracks 12 dirty albums 22 dirty performers 75 dirty works 76 dirty performances 0 clumping tracks, 0 clumping auxfiles 0 compute tracks, 0 deleted tracks, 0 tracks to (re)load, 0 tracks to retain, 0 auxfiles to (re)load, 0 auxfiles to retain, and 186 changed objects
03/26 09:47:22 Trace: [roondns] flushed 46 last-known-good entries
03/26 09:47:22 Info: [library/albumdetails] found 1 ingroup alternates, 0 other alternates
03/26 09:47:22 Trace: [music/searchindex] [search-index]  removed in 0ms: 1 albums, 0 tracks, 0 works, 0 performers, 0 labels, 0 genres
03/26 09:47:22 Trace: [dbperf] flush 0 bytes, 0 ops in 1 ms (cumulative 410551394 bytes, 208834 ops in 33496 ms)
03/26 09:47:22 Trace: [library] endmutation in 118ms
03/26 09:47:22 Trace: [music/searchindex] [search-index] added in 49ms: 1 albums, 0 tracks, 0 works, 0 performers, 0 labels, 0 genres
03/26 09:47:22 Trace: [music/searchindex] totals: 2139 albums, 26499 tracks, 18804 works, 38211 performers, 824 labels, 1261 genres
03/26 09:47:23 Debug: [easyhttp] [24647] GET to https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&intent=stream&request_sig=2e2de7889dafedc4e913d5c271f4ab20&request_ts=1711460842&track_id=2006637 returned after 600 ms, status code: 200, request body size: 0 B
03/26 09:47:23 Info: [Library Evo 150] [zoneplayer] Queueing: https://streaming-qobuz-std.akamaized.net/file
03/26 09:47:23 Info: FTMSI-B new FileCache qo/7F17B6CB
>>> /Users/jason/Library/RoonServer/Cache/smc.db/bfc/540.cache
>>> https://streaming-qobuz-std.akamaized.net/file
03/26 09:47:23 Debug: FTMSI-B Cache open file qo/7F17B6CB domain: zoneplayer:1147 ordinal:3
03/26 09:47:23 Debug: FTMSI-B qo/7F17B6CB download status: DownloadNotStarted accessTimeout:False openFiles:1 prev:no
03/26 09:47:23 Info: FTMSI-B qo/7F17B6CB: allocated bw changed from 0 to 51200 kbps
03/26 09:47:23 Info: FTMSI-B 1 FileCache qo/0B6B6DC0 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':64) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 2 FileCache qo/7B9B6122 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':158) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 3 FileCache qo/859E3976 dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':427) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 4 FileCache qo/759DC874 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':167) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 5 FileCache qo/2429A3BB dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':426) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 6 FileCache qo/7EFBA6CC dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':14) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 7 FileCache qo/3E790878 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':15) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 8 FileCache qo/186F526F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':26) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 9 FileCache qo/445AF3C6 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':27) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 10 FileCache qo/9C05F139 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':157) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 11 FileCache qo/1C2FF268 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':65) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 12 FileCache qo/D2C5A425 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':97) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 13 FileCache qo/DB3CBB0F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':168) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 14 FileCache qo/DC8B5663 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':98) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 15 FileCache qo/55868676 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':16) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 16 FileCache qo/7AC758F8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':13) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 17 FileCache qo/3B73CE7D dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':15) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 18 FileCache qo/DF3F96EF dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':14) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 19 FileCache qo/ACDD6D17 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':16) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 20 FileCache qo/1BDD2F3A dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':17) --> bw limit:0kbps
03/26 09:47:23 Debug: FTMSI-B-OE qo/7F17B6CB created new req 1 for block 0 p 4294967295; active requests 1
03/26 09:47:23 Info: FTMSI-B 21 FileCache qo/D5322EC1 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':7) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 22 FileCache qo/5989A706 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':8) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 23 FileCache qo/84CA9F48 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':13) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 24 FileCache qo/FC5470B3 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':14) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 25 FileCache qo/4A7922A4 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':4) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 26 FileCache qo/102C670F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':14) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 27 FileCache qo/74F96FDD dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':15) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 28 FileCache qo/5157E526 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':5) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 29 FileCache qo/E0CFEDE8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1136':4) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 30 FileCache qo/74A88F5F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':20) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 31 FileCache qo/B49ADAE9 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':21) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 32 FileCache qo/926B209F dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:1136':5) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 33 FileCache qo/F3A7532C dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1147':1) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 34 FileCache qo/319336CB dwStatus:AllBlocksDownloaded files:1 accessTimeOut:False priorities: ('zoneplayer:1147':2) --> bw limit:0kbps
03/26 09:47:23 Info: FTMSI-B 35 FileCache qo/7F17B6CB dwStatus:DownloadNotStarted files:1 accessTimeOut:False priorities: ('zoneplayer:1147':3) --> bw limit:51200kbps
03/26 09:47:23 Info: FTMSI-B FileCache removed qo/F3A7532C
03/26 09:47:23 Debug: FTMSI-B-OE qo/F3A7532C exit thread signalled
03/26 09:47:23 Trace: FTMSI-B 1 FileCache qo/0B6B6DC0 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':64) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 2 FileCache qo/7B9B6122 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':158) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 3 FileCache qo/859E3976 dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':427) --> bw limit:0kbps
03/26 09:47:23 Debug: FTMSI-B-OE qo/F3A7532C exit thread signalled
03/26 09:47:23 Trace: FTMSI-B 4 FileCache qo/759DC874 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':167) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 5 FileCache qo/2429A3BB dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':426) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 6 FileCache qo/7EFBA6CC dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':14) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 7 FileCache qo/3E790878 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':15) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 8 FileCache qo/186F526F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':26) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 9 FileCache qo/445AF3C6 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':27) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 10 FileCache qo/9C05F139 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':157) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 11 FileCache qo/1C2FF268 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':65) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 12 FileCache qo/D2C5A425 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':97) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 13 FileCache qo/DB3CBB0F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':168) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 14 FileCache qo/DC8B5663 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':98) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 15 FileCache qo/55868676 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':16) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 16 FileCache qo/7AC758F8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':13) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 17 FileCache qo/3B73CE7D dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':15) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 18 FileCache qo/DF3F96EF dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':14) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 19 FileCache qo/ACDD6D17 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':16) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 20 FileCache qo/1BDD2F3A dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':17) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 21 FileCache qo/D5322EC1 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':7) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 22 FileCache qo/5989A706 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':8) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 23 FileCache qo/84CA9F48 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':13) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 24 FileCache qo/FC5470B3 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':14) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 25 FileCache qo/4A7922A4 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':4) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 26 FileCache qo/102C670F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':14) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 27 FileCache qo/74F96FDD dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':15) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 28 FileCache qo/5157E526 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':5) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 29 FileCache qo/E0CFEDE8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1136':4) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 30 FileCache qo/74A88F5F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':20) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 31 FileCache qo/B49ADAE9 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':21) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 32 FileCache qo/926B209F dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:1136':5) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 33 FileCache qo/319336CB dwStatus:AllBlocksDownloaded files:1 accessTimeOut:False priorities: ('zoneplayer:1147':2) --> bw limit:0kbps
03/26 09:47:23 Trace: FTMSI-B 34 FileCache qo/7F17B6CB dwStatus:DownloadNotStarted files:1 accessTimeOut:False priorities: ('zoneplayer:1147':3) --> bw limit:51200kbps
03/26 09:47:23 Info: FTMSI-B FileCache disposed qo/F3A7532C
03/26 09:47:23 Trace: [roondns] flushed 46 last-known-good entries
03/26 09:47:23 Debug: [easyhttp] [24646] POST to https://www.qobuz.com/api.json/0.2/track/reportStreamingStart? returned after 1244 ms, status code: 201, request body size: 358 B
03/26 09:47:24 Debug: [easyhttp] [24645] POST to https://www.qobuz.com/api.json/0.2/track/reportStreamingEnd? returned after 1626 ms, status code: 200, request body size: 360 B
03/26 09:47:24 Debug: [easyhttp] [24648] GET to https://streaming-qobuz-std.akamaized.net/file?uid=1877161&eid=2006637&fmt=6&profile=raw&app_id=188245549&cid=1298357&etsp=1711464443&hmac=xk9Uf-wvnZ-n-4Ofd8cny5GPJu8 returned after 991 ms, status code: 200, request body size: 0 B
03/26 09:47:24 Debug: FTMSI-B got length for qo/7F17B6CB; 37.1 MBytes
03/26 09:47:24 Debug: FTMSI-B qo/7F17B6CB download status: FileLengthRetrieved accessTimeout:True openFiles:1 prev:(DownloadNotStarted,False,1)
03/26 09:47:24 Debug: FTMSI-B-OE set min bandwidth for qo/7F17B6CB to 894 kbps
03/26 09:47:24 Info: FTMSI-B-OE qo/7F17B6CB rid:1 response took 1196ms
03/26 09:47:24 Debug: FTMSI-B qo/7F17B6CB download status: FirstBlockRetrieved accessTimeout:False openFiles:1 prev:(FileLengthRetrieved,True,1)
03/26 09:47:24 Info: [Library Evo 150] [zoneplayer] Open result (Queueing): Result[Status=Success]
03/26 09:47:25 Debug: FTMSI-B qo/7F17B6CB download status: FirstBlockRetrieved accessTimeout:True openFiles:1 prev:(FirstBlockRetrieved,False,1)
03/26 09:47:26 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:03/6:57] With These Hands (Album Version) - Yellowjackets / Russell Ferrante / William Kennedy
03/26 09:47:31 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:09/6:57] With These Hands (Album Version) - Yellowjackets / Russell Ferrante / William Kennedy
03/26 09:47:33 Trace: [roondns] flushed 46 last-known-good entries
03/26 09:47:33 Debug: [easyhttp] [24649] POST to https://api.roonlabs.net/device-map/1/register returned after 301 ms, status code: 200, request body size: 9 KB
03/26 09:47:33 Trace: [devicemap] device map updated
03/26 09:47:35 Info: [stats] 415704mb Virtual, 5976mb Physical, 5539mb Managed
03/26 09:47:36 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:13/6:57] With These Hands (Album Version) - Yellowjackets / Russell Ferrante / William Kennedy
03/26 09:47:41 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:18/6:57] With These Hands (Album Version) - Yellowjackets / Russell Ferrante / William Kennedy
03/26 09:47:44 Trace: [library] endmutation in 31ms
03/26 09:47:46 Trace: [library] endmutation in 26ms
03/26 09:47:46 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:24/6:57] With These Hands (Album Version) - Yellowjackets / Russell Ferrante / William Kennedy
03/26 09:47:49 Trace: [library] endmutation in 17ms
03/26 09:47:49 Debug: FTMSI-B-OE qo/7F17B6CB exit thread signalled
03/26 09:47:49 Debug: FTMSI-B qo/7F17B6CB download status: AllBlocksDownloaded accessTimeout:True openFiles:1 prev:(FirstBlockRetrieved,True,1)
03/26 09:47:49 Info: FTMSI-B qo/7F17B6CB: allocated bw changed from 51200 to 0 kbps
03/26 09:47:49 Info: FTMSI-B 1 FileCache qo/0B6B6DC0 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':64) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 2 FileCache qo/7B9B6122 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':158) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 3 FileCache qo/859E3976 dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':427) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 4 FileCache qo/759DC874 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':167) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 5 FileCache qo/2429A3BB dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:4':426) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 6 FileCache qo/7EFBA6CC dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':14) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 7 FileCache qo/3E790878 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:5':15) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 8 FileCache qo/186F526F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':26) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 9 FileCache qo/445AF3C6 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':27) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 10 FileCache qo/9C05F139 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:10':157) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 11 FileCache qo/1C2FF268 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':65) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 12 FileCache qo/D2C5A425 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':97) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 13 FileCache qo/DB3CBB0F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:24':168) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 14 FileCache qo/DC8B5663 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:33':98) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 15 FileCache qo/55868676 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':16) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 16 FileCache qo/7AC758F8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':13) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 17 FileCache qo/3B73CE7D dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:54':15) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 18 FileCache qo/DF3F96EF dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:53':14) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 19 FileCache qo/ACDD6D17 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':16) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 20 FileCache qo/1BDD2F3A dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:97':17) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 21 FileCache qo/D5322EC1 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':7) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 22 FileCache qo/5989A706 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:103':8) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 23 FileCache qo/84CA9F48 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':13) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 24 FileCache qo/FC5470B3 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:133':14) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 25 FileCache qo/4A7922A4 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':4) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 26 FileCache qo/102C670F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':14) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 27 FileCache qo/74F96FDD dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:169':15) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 28 FileCache qo/5157E526 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:190':5) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 29 FileCache qo/E0CFEDE8 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1136':4) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 30 FileCache qo/74A88F5F dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':20) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 31 FileCache qo/B49ADAE9 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:265':21) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 32 FileCache qo/926B209F dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:1136':5) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 33 FileCache qo/319336CB dwStatus:AllBlocksDownloaded files:1 accessTimeOut:False priorities: ('zoneplayer:1147':2) --> bw limit:0kbps
03/26 09:47:49 Info: FTMSI-B 34 FileCache qo/7F17B6CB dwStatus:AllBlocksDownloaded files:1 accessTimeOut:True priorities: ('zoneplayer:1147':3) --> bw limit:0kbps
03/26 09:47:49 Debug: FTMSI-B-OE qo/7F17B6CB rid:1 request ended -- first block: 0 blocks read: 1189 download speed: 12246kbps response time: 1196ms
03/26 09:47:50 Trace: [library] endmutation in 20ms
03/26 09:47:50 Info: [stats] 415770mb Virtual, 5680mb Physical, 6086mb Managed
03/26 09:47:50 Trace: [library] endmutation in 19ms
03/26 09:47:51 Trace: [library] endmutation in 31ms
03/26 09:47:51 Info: [cast] lost device CastDevice[DeviceId=AVM-70-d2dcd0e41aaf8d6659003a4568197d74._googlecast._tcp.local, Name=AVM 70, Address=10.0.1.7] because it disconnected
03/26 09:47:51 Trace: [library] endmutation in 21ms
03/26 09:47:52 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PLAYING @ 0:29/6:57] With These Hands (Album Version) - Yellowjackets / Russell Ferrante / William Kennedy
03/26 09:47:53 Trace: [raat_ll/client] [Cambridge Audio Evo 150 @ 10.0.1.2:45515] no data received for >10000ms. Killing connection.
03/26 09:47:53 Trace: [raat] [Cambridge Audio Evo 150 @ 10.0.1.2:45515] => Disconnected
03/26 09:47:53 Trace: [raat] [Cambridge Audio Evo 150 @ 10.0.1.2:45515] lost client connection. Retrying
03/26 09:47:53 Trace: [raat] [Cambridge Audio Evo 150 @ 10.0.1.2:45515] connecting (attempt 1)
03/26 09:47:53 Info: [transport] destroyed zone Library Evo 150 was playing? True
03/26 09:47:53 Trace: [zone Library Evo 150] Suspend
03/26 09:47:53 Info: [zone Library Evo 150] OnPlayFeedback Stopped
03/26 09:47:53 Debug: FTMSI-B closed file for qo/7F17B6CB; open files:0
03/26 09:47:53 Info: [zone Library Evo 150] Canceling Pending Sleep
03/26 09:47:53 Debug: FTMSI-B qo/7F17B6CB download status: AllBlocksDownloaded accessTimeout:True openFiles:0 prev:(AllBlocksDownloaded,True,1)
03/26 09:47:53 Info: [zone Library Evo 150] Canceling Pending Sleep
03/26 09:47:53 Debug: FTMSI-B closed file for qo/319336CB; open files:0
03/26 09:47:53 Debug: [raat/tcpaudiosource] disconnecting
03/26 09:47:53 Debug: FTMSI-B qo/319336CB download status: AllBlocksDownloaded accessTimeout:False openFiles:0 prev:(AllBlocksDownloaded,False,1)
03/26 09:47:53 Trace: [raat] [Cambridge Audio Evo 150 @ 10.0.1.2:45515] => Connecting
03/26 09:47:53 Info: [audio/env] [zoneplayer -> stream] All streams were disposed
03/26 09:47:53 Trace: [Library Evo 150] [zoneplayer/raat] Endpoint Cambridge Audio Evo 150 State Changed: Playing => Prepared
03/26 09:47:53 Info: [audio/env] [zoneplayer -> stream -> endpoint] All streams were disposed
03/26 09:47:53 Info: [audio/env] [zoneplayer] All streams were disposed
03/26 09:47:53 Info: sleep 185ms after flush
03/26 09:47:53 Trace: [raat_ll/client] [Bluesound N330 @ 10.0.1.185:41945] no data received for >10000ms. Killing connection.
03/26 09:47:53 Trace: [raat] [Bluesound N330 @ 10.0.1.185:41945] => Disconnected
03/26 09:47:53 Trace: [raat] [Bluesound N330 @ 10.0.1.185:41945] lost client connection. Retrying
03/26 09:47:53 Trace: [raat] [Bluesound N330 @ 10.0.1.185:41945] connecting (attempt 1)
03/26 09:47:53 Info: [transport] destroyed zone Jason’s POWERNODE - 5B32 was playing? False
03/26 09:47:53 Trace: [zone Jason’s POWERNODE - 5B32] Suspend
03/26 09:47:53 Info: [zone Jason’s POWERNODE - 5B32] Canceling Pending Sleep
03/26 09:47:53 Info: [zone Jason’s POWERNODE - 5B32] Canceling Pending Sleep
03/26 09:47:53 Trace: [raat] [Bluesound N330 @ 10.0.1.185:41945] => Connecting
03/26 09:47:53 Trace: [raat_ll/client] [Bluesound VAULT 2i @ 10.0.1.6:43311] no data received for >10000ms. Killing connection.
03/26 09:47:53 Trace: [raat] [Bluesound VAULT 2i @ 10.0.1.6:43311] => Disconnected
03/26 09:47:53 Trace: [raat] [Bluesound VAULT 2i @ 10.0.1.6:43311] lost client connection. Retrying
03/26 09:47:53 Trace: [raat] [Bluesound VAULT 2i @ 10.0.1.6:43311] connecting (attempt 1)
03/26 09:47:53 Info: [transport] destroyed zone VAULT 2i - 69B7 was playing? False
03/26 09:47:53 Trace: [zone VAULT 2i - 69B7] Suspend
03/26 09:47:53 Info: [zone VAULT 2i - 69B7] Canceling Pending Sleep
03/26 09:47:53 Info: [zone VAULT 2i - 69B7] Canceling Pending Sleep
03/26 09:47:53 Trace: [raat] [Bluesound VAULT 2i @ 10.0.1.6:43311] => Connecting
03/26 09:47:53 Trace: [raat_ll/client] [System Output] no data received for >10000ms. Killing connection.
03/26 09:47:53 Trace: [raatserver] [System Output] lost client connection. Retrying
03/26 09:47:53 Info: [raatserver] [System Output] connecting (attempt 1)
03/26 09:47:53 Info: [transport] destroyed zone System Output was playing? False
03/26 09:47:53 Trace: [zone System Output] Suspend
03/26 09:47:53 Info: [zone System Output] Canceling Pending Sleep
03/26 09:47:53 Info: [zone System Output] Canceling Pending Sleep
03/26 09:47:54 Trace: [library] endmutation in 23ms
03/26 09:47:54 Trace: [raat_ll/client] [Bluesound N130 @ 10.0.1.174:45113] no data received for >10000ms. Killing connection.
03/26 09:47:54 Trace: [raat] [Bluesound N130 @ 10.0.1.174:45113] => Disconnected
03/26 09:47:54 Trace: [raat] [Bluesound N130 @ 10.0.1.174:45113] lost client connection. Retrying
03/26 09:47:54 Trace: [raat] [Bluesound N130 @ 10.0.1.174:45113] connecting (attempt 1)
03/26 09:47:54 Info: [transport] destroyed zone PULSE 2i - 9727 + Exercise Room NODE - B8CA was playing? False
03/26 09:47:54 Trace: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] Suspend
03/26 09:47:54 Info: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] Canceling Pending Sleep
03/26 09:47:54 Info: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] Canceling Pending Sleep
03/26 09:47:54 Info: Created Stub for 23:1:c7032a6b-1908-eead-1e47-656f36be7c27
03/26 09:47:54 Trace: [zone PULSE 2i - 9727 + Bluesound NODE] Loading from /Users/jason/Library/RoonServer/Database/Core/324e013fcbcc4174b66215e1932c6442/transport/zone_1601bd20bcb23792f844ab2b9b464d37dc10.db
03/26 09:47:55 Trace: [zone PULSE 2i - 9727 + Bluesound NODE] Suspend
03/26 09:47:55 Info: [zone PULSE 2i - 9727 + Bluesound NODE] Canceling Pending Sleep
03/26 09:47:55 Trace: [PULSE 2i - 9727] [zoneplayer/raat] Endpoint Bluesound PULSE 2i Initial State: Idle
03/26 09:47:55 Info: [transport] created zone PULSE 2i - 9727 + Bluesound NODE
03/26 09:47:55 Info: [transport]     with endpoint Bluesound PULSE 2i (23:1:5f7c4f61-2300-19d6-dac9-cde741f3dff9) [IsAvailable=True]
03/26 09:47:55 Info: [transport]     with endpoint Bluesound NODE (23:1:c7032a6b-1908-eead-1e47-656f36be7c27) [IsAvailable=False]
03/26 09:47:55 Trace: [PULSE 2i - 9727] [Enhanced, 16/44 QOBUZ FLAC => 24/44] [100% buf] [STOPPED @ 0:00] 
03/26 09:47:55 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] SENT [10]{"request":"update_artwork"}
03/26 09:47:55 Trace: [Exercise Room NODE - B8CA] [Lossless, 16/44 QOBUZ FLAC => 16/44] [100% buf] [STOPPED @ 0:00] 
03/26 09:47:55 Trace: [raat] [Bluesound N130 @ 10.0.1.174:45113] => Connecting
03/26 09:47:55 Trace: [library] endmutation in 66ms
03/26 09:47:55 Trace: [raat_ll/client] [Bluesound N130 @ 10.0.1.159:37841] no data received for >10000ms. Killing connection.
03/26 09:47:55 Trace: [rnet/RnetJsonClient] no data received for >10000ms. Killing connection.
03/26 09:47:55 Warn: [raat_ll/client] [Bluesound PULSE 2i @ 10.0.1.190:36157] error writing to connection: System.NullReferenceException: Arg_NullReferenceException
   at Sooloos.Audio.Raat.Client._BeginWrite()
03/26 09:47:55 Trace: [raat] [Rose RS520 @ 10.0.1.3:45865] => Disconnected
03/26 09:47:55 Trace: [raat] [Rose RS520 @ 10.0.1.3:45865] lost client connection. Retrying
03/26 09:47:55 Trace: [raat] [Rose RS520 @ 10.0.1.3:45865] connecting (attempt 1)
03/26 09:47:55 Info: [transport] destroyed zone Kitchen was playing? False
03/26 09:47:55 Trace: [zone Kitchen] Suspend
03/26 09:47:55 Info: [zone Kitchen] Canceling Pending Sleep
03/26 09:47:55 Info: [zone Kitchen] Canceling Pending Sleep
03/26 09:47:55 Trace: [raat] [Bluesound N130 @ 10.0.1.159:37841] => Disconnected
03/26 09:47:55 Trace: [raat] [Bluesound N130 @ 10.0.1.159:37841] lost client connection. Retrying
03/26 09:47:55 Trace: [raat] [Bluesound N130 @ 10.0.1.159:37841] connecting (attempt 1)
03/26 09:47:55 Info: [transport] destroyed zone Master Bath Node was playing? False
03/26 09:47:55 Trace: [zone Master Bath Node] Suspend
03/26 09:47:55 Info: [zone Master Bath Node] Canceling Pending Sleep
03/26 09:47:55 Info: [zone Master Bath Node] Canceling Pending Sleep
03/26 09:47:55 Trace: [raatserver] [RaatServer Jasons-Mac-mini @ 127.0.0.1:9200] lost client connection. Retrying
03/26 09:47:55 Trace: [raatserver] [RaatServer Jasons-Mac-mini @ 127.0.0.1:9200] connecting (attempt 1)
03/26 09:47:55 Trace: [raat] [Bluesound PULSE 2i @ 10.0.1.190:36157] => Disconnected
03/26 09:47:55 Trace: [raat] [Bluesound PULSE 2i @ 10.0.1.190:36157] lost client connection. Retrying
03/26 09:47:55 Trace: [raat] [Bluesound PULSE 2i @ 10.0.1.190:36157] connecting (attempt 1)
03/26 09:47:55 Info: [transport] destroyed zone PULSE 2i - 9727 + Exercise Room NODE - B8CA was playing? False
03/26 09:47:55 Trace: [zone PULSE 2i - 9727 + Bluesound NODE] Suspend
03/26 09:47:55 Info: [zone PULSE 2i - 9727 + Bluesound NODE] Canceling Pending Sleep
03/26 09:47:55 Info: [zone PULSE 2i - 9727 + Bluesound NODE] Canceling Pending Sleep
03/26 09:47:55 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] Initializing RAAT session
03/26 09:47:55 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/base.lua as module base [1088 chars]
03/26 09:47:55 Trace: [System Output] [raatclient] Initializing RAAT session
03/26 09:47:55 Trace: [library] endmutation in 29ms
03/26 09:47:55 Trace: [System Output] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/base.lua as module base [1088 chars]
03/26 09:47:55 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] Initializing RAAT session
03/26 09:47:55 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/base.lua as module base [1088 chars]
03/26 09:47:55 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] Initializing RAAT session
03/26 09:47:55 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/base.lua as module base [1088 chars]
03/26 09:47:55 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] Initializing RAAT session
03/26 09:47:55 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/base.lua as module base [1088 chars]
03/26 09:47:55 Trace: [raat] [Rose RS520 @ 10.0.1.3:45865] => Connecting
03/26 09:47:55 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] Initializing RAAT session
03/26 09:47:55 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/base.lua as module base [1088 chars]
03/26 09:47:55 Trace: [raat] [Bluesound N130 @ 10.0.1.159:37841] => Connecting
03/26 09:47:55 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] Initializing RAAT session
03/26 09:47:55 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/base.lua as module base [1088 chars]
03/26 09:47:55 Trace: [raatserver] [RaatServer Jasons-Mac-mini @ 127.0.0.1:9200] connected
03/26 09:47:55 Trace: [rnet/RnetJsonClient] SENT {"request":"enumerate_devices","subscription_id":"0"}
03/26 09:47:55 Trace: [raat] [Bluesound PULSE 2i @ 10.0.1.190:36157] => Connecting
03/26 09:47:55 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] Initializing RAAT session
03/26 09:47:55 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/base.lua as module base [1088 chars]
03/26 09:47:55 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/dkjson.lua as module dkjson [22416 chars]
03/26 09:47:55 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/dkjson.lua as module dkjson [22416 chars]
03/26 09:47:55 Trace: [rnet/RnetJsonClient] GOT NONFINAL {"devices": [{"device_id": "AppleUSBAudioEngine:Apple Inc.:Display Audio:44001016:2,1", "type": "coreaudio", "usb_id": "05ac:1105", "name": "Display Audio", "vendor": "Apple Inc."}, {"device_id": "BuiltInSpeakerDevice", "type": "coreaudio", "name": "Mac mini Speakers", "vendor": "Apple Inc."}, {"config": {"output": {"type": "coreaudio", "device": "default", "name": "System Output"}, "unique_id": "9219b9f1-180d-41fe-97b4-90a006525072", "external_config": {}, "volume": {"type": "coreaudio", "device": "default"}}, "discovery_data": {"tcp_port": 65102, "vendor": "N/A", "raat_version": "1.1.39", "unique_id": "9219b9f1-180d-41fe-97b4-90a006525072", "protocol_version": "3", "version": "N/A", "model": "N/A"}, "device_id": "default", "type": "coreaudio", "name": "System Output", "is_system_output": true}, {"device_id": "06102692-0000-0000-1016-0104B53C2278", "type": "coreaudio", "name": "LED Cinema", "vendor": "APP"}], "status": "Success"}
03/26 09:47:55 Info: [raatserver] GOT DEVICE 5c050641-0940-40e5-9cca-6cfa5c3b295f::AppleUSBAudioEngine:Apple Inc.:Display Audio:44001016:2,1 Type=coreaudio Name=Display Audio Vendor=Apple Inc.UsbId=05ac:1105
03/26 09:47:55 Info: [raatserver] GOT DEVICE 5c050641-0940-40e5-9cca-6cfa5c3b295f::BuiltInSpeakerDevice Type=coreaudio Name=Mac mini Speakers Vendor=Apple Inc.
03/26 09:47:55 Info: [raatserver] GOT DEVICE 5c050641-0940-40e5-9cca-6cfa5c3b295f::default Type=coreaudio Name=System Output 
03/26 09:47:55 Info: [raatserver] GOT DEVICE 5c050641-0940-40e5-9cca-6cfa5c3b295f::06102692-0000-0000-1016-0104B53C2278 Type=coreaudio Name=LED Cinema Vendor=APP
03/26 09:47:55 Trace: [rnet/RnetJsonClient] SENT {"request":"enable_device","device_id":"default","subscription_id":"193"}
03/26 09:47:55 Info: [raatserver] [System Output] connecting (attempt 1)
03/26 09:47:55 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/dkjson.lua as module dkjson [22416 chars]
03/26 09:47:55 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/dkjson.lua as module dkjson [22416 chars]
03/26 09:47:55 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/dkjson.lua as module dkjson [22416 chars]
03/26 09:47:55 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/protocol.lua as module protocol [2045 chars]
03/26 09:47:55 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/dkjson.lua as module dkjson [22416 chars]
03/26 09:47:55 Trace: [rnet/RnetJsonClient] GOT NONFINAL {"status": "Success"}
03/26 09:47:55 Trace: [System Output] [raatclient] Initializing RAAT session
03/26 09:47:55 Trace: [System Output] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/base.lua as module base [1088 chars]
03/26 09:47:55 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/dkjson.lua as module dkjson [22416 chars]
03/26 09:47:55 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/protocol.lua as module protocol [2045 chars]
03/26 09:47:55 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/protocol.lua as module protocol [2045 chars]
03/26 09:47:55 Trace: [System Output] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/dkjson.lua as module dkjson [22416 chars]
03/26 09:47:55 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/roon_tcp.lua [45404 chars]
03/26 09:47:55 Trace: [System Output] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/protocol.lua as module protocol [2045 chars]
03/26 09:47:55 Trace: [System Output] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/roon_tcp.lua [45404 chars]
03/26 09:47:55 Trace: [System Output] [raatclient] RAAT Session initialized in 6ms
03/26 09:47:55 Trace: [System Output] [raatclient] SENT [2]{"request":"info"}
03/26 09:47:55 Trace: [System Output] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
03/26 09:47:55 Trace: [System Output] [raatclient] GOT [2] {"info":{"protocol_version":"3","version":"N/A","model":"N/A","vendor":"N/A","unique_id":"9219b9f1-180d-41fe-97b4-90a006525072","raat_version":"1.1.39"},"platform":{"os":"osx","uname":{"version":"Darwin Kernel Version 23.2.0: Wed Nov 15 21:53:34 PST 2023; root:xnu-10002.61.3~2/RELEASE_ARM64_T8103","release":"23.2.0","machine":"arm64","sysname":"Darwin","nodename":"Jasons-Mac-mini.local"}},"flags":{"has_write_chmap":true},"status":"Success","source_selection":{"info":[],"is_supported":false},"output":{"info":{"config":{"name":"System Output","device":"default","type":"coreaudio"}},"supported_formats":"48000/24/1|2,48000/16/1|2,44100/24/1|2,44100/16/1|2"},"volume":{"info":{"config":{"type":"coreaudio","device":"default"}},"is_supported":true},"transport":{"info":[],"is_supported":false}}
03/26 09:47:55 Trace: [System Output] [raatclient] GOT [3] {"status":"Success"}
03/26 09:47:55 Trace: [raatserver] [System Output] connected
03/26 09:47:55 Info: [transport] creating endpoint for raat device 9219b9f1-180d-41fe-97b4-90a006525072
03/26 09:47:55 Trace: [System Output] [raatclient] SENT [4]{"request":"subscribe_transport"}
03/26 09:47:55 Trace: [System Output] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"27250a6d-660b-458b-af45-9e8967d8beef"}
03/26 09:47:55 Trace: [dspengine] created new dsp config {"version":3,"items":[{"type":"bs2b","enabled":false},{"type":"parametric_equalizer","enabled":false},{"type":"audeze_presets","enabled":false}]}
03/26 09:47:55 Trace: [transport/audeze] picking preset lowlatency 
03/26 09:47:55 Trace: [transport/audeze] picked null preset!
03/26 09:47:55 Trace: [System Output] [raatclient] GOT [5] {"action":"Changed","controls":{"volume":{"info":{"config":{"type":"coreaudio","device":"default"}},"max":100.0,"type":"number","min":0.0,"step":1.0,"mute":false,"value":100}},"status":"Success"}
03/26 09:47:55 Trace: [zone System Output] Loading from /Users/jason/Library/RoonServer/Database/Core/324e013fcbcc4174b66215e1932c6442/transport/zone_1601f1b919920d18fe4197b490a006525072.db
03/26 09:47:55 Trace: [library] endmutation in 22ms
03/26 09:47:55 Trace: [zone System Output] Suspend
03/26 09:47:55 Info: [zone System Output] Canceling Pending Sleep
03/26 09:47:55 Trace: [System Output] [zoneplayer/raat] Endpoint System Output Initial State: Idle
03/26 09:47:55 Info: [transport] created zone System Output
03/26 09:47:55 Info: [transport]     with endpoint System Output (23:1:9219b9f1-180d-41fe-97b4-90a006525072) [IsAvailable=True]
03/26 09:47:55 Trace: [System Output] [Inactive] [STOPPED @ 0:00] 
03/26 09:47:55 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/roon_tcp.lua [45404 chars]
03/26 09:47:55 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/roon_tcp.lua [45404 chars]
03/26 09:47:55 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/protocol.lua as module protocol [2045 chars]
03/26 09:47:55 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/protocol.lua as module protocol [2045 chars]
03/26 09:47:55 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] RAAT Session initialized in 119ms
03/26 09:47:55 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] SENT [2]{"request":"info"}
03/26 09:47:55 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
03/26 09:47:55 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/protocol.lua as module protocol [2045 chars]
03/26 09:47:55 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/protocol.lua as module protocol [2045 chars]
03/26 09:47:56 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] GOT [2] {"flags":{"has_write_chmap":true},"source_selection":{"is_supported":true,"info":{}},"volume":{"is_supported":true,"info":{}},"transport":{"info":{},"is_update_status_supported":true,"is_supported":true,"is_update_artwork_supported":true},"platform":{"uname":{"release":"6.4.0-01742-g13af13e216f7","nodename":"VAULT2i-69B7","machine":"armv7l","version":"#1 SMP PREEMPT Wed Nov 15 19:36:37 UTC 2023","sysname":"Linux"},"os":"linux"},"info":{"unique_id":"BluOS:90:56:82:bf:69:b7"},"status":"Success","output":{"info":{"mqa_capabilities":["renderer","decoder"]},"supported_formats":"32000/24/2,24000/24/2,22050/24/2,32000/16/2,48000/24/2,24000/16/2,88200/24/2,176400/24/2,88200/16/2,44100/16/2,176400/16/2,22050/16/2,96000/24/2,44100/24/2,96000/16/2,192000/24/2,192000/16/2,48000/16/2"}}
03/26 09:47:56 Trace: [raat] [Bluesound VAULT 2i @ 10.0.1.6:43311] => Connected
03/26 09:47:56 Trace: [raat] [Bluesound VAULT 2i @ 10.0.1.6:43311] connected
03/26 09:47:56 Info: [transport] creating endpoint for raat device BluOS:90:56:82:bf:69:b7
03/26 09:47:56 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] SENT [4]{"request":"subscribe_transport"}
03/26 09:47:56 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"27250a6d-660b-458b-af45-9e8967d8beef"}
03/26 09:47:56 Trace: [dspengine] loaded DSP config {"version":3,"items":[{"type":"parametric_equalizer","enabled":false,"bands":[{"type":"low_shelf","frequency":63,"gain_db":9,"q":0.6,"is_enabled":true},{"type":"high_shelf","frequency":16000,"gain_db":6,"q":0.4,"is_enabled":true},{"type":"equalize_frequency","frequency":16000,"gain_db":3,"q":1,"is_enabled":false},{"type":"equalize_frequency","frequency":2600,"gain_db":-1.8,"q":0.8,"is_enabled":false},{"type":"equalize_frequency","frequency":7500,"gain_db":-1.8,"q":1,"is_enabled":false},{"type":"high_pass","frequency":16000,"order":1,"is_enabled":false},{"type":"low_pass","frequency":20000,"order":1,"is_enabled":false}],"gain_db":-9,"y_axis_min_db":-24,"y_axis_max_db":24},{"type":"speaker_setup","enabled":false,"speaker_rules_2.0":[{"channel":0,"gain_db":0,"distance_cm":0,"invert_phase":false},{"channel":1,"gain_db":0,"distance_cm":0,"invert_phase":false}]}],"headroom_adjustment":{"type":"headroom_adjustment","enable_clipping_indicator":true,"enabled":false,"gain_db":-3},"sample_rate_conversion":{"type":"sample_rate_conversion"}}
03/26 09:47:56 Trace: [library] endmutation in 26ms
03/26 09:47:56 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] GOT [3] {"status":"Success"}
03/26 09:47:56 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] GOT [5] {"action":"Changed","status":"Success","controls":{"volume":{"value":100,"max":100.0,"min":0.0,"step":1.0,"info":{},"mute":false,"type":"number"},"source":{"value":"standby","info":{}}}}
03/26 09:47:56 Trace: [zone VAULT 2i - 69B7] Loading from /Users/jason/Library/RoonServer/Database/Core/324e013fcbcc4174b66215e1932c6442/transport/zone_16013601f90f0a6758927956d6b91c112b92.db
03/26 09:47:56 Trace: [library] endmutation in 23ms
03/26 09:47:56 Trace: [zone VAULT 2i - 69B7] Suspend
03/26 09:47:56 Info: [zone VAULT 2i - 69B7] Canceling Pending Sleep
03/26 09:47:56 Trace: [VAULT 2i - 69B7] [zoneplayer/raat] Endpoint Bluesound VAULT 2i Initial State: Idle
03/26 09:47:56 Info: [transport] created zone VAULT 2i - 69B7
03/26 09:47:56 Info: [transport]     with endpoint Bluesound VAULT 2i (23:1:0ff90136-670a-9258-7956-d6b91c112b92) [IsAvailable=True]
03/26 09:47:56 Trace: [VAULT 2i - 69B7] [Lossless, 16/44 FLAC => 16/44] [100% buf] [STOPPED @ 0:00] 
03/26 09:47:56 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/roon_tcp.lua [45404 chars]
03/26 09:47:56 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/roon_tcp.lua [45404 chars]
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/roon_tcp.lua [45404 chars]
03/26 09:47:56 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] Loading script /Applications/Roon.app/Contents/RoonServer.app/Contents/RoonAppliance.app/Contents/Resources/roon_tcp.lua [45404 chars]
03/26 09:47:56 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] RAAT Session initialized in 271ms
03/26 09:47:56 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] SENT [2]{"request":"info"}
03/26 09:47:56 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] RAAT Session initialized in 303ms
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] SENT [2]{"request":"info"}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
03/26 09:47:56 Info: [cast] lost device CastDevice[DeviceId=Cambridge-Audio-Evo--11e0619fdc57e148eea506a00afe16ec._googlecast._tcp.local, Name=Cambridge Audio Evo 150, Address=10.0.1.2] because it disconnected
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] GOT [2] {"status":"Success","info":{"unique_id":"BluOS:90:56:82:41:b8:ca"},"transport":{"is_update_artwork_supported":true,"is_update_status_supported":true,"is_supported":true,"info":{}},"flags":{"has_write_chmap":true},"output":{"info":{"mqa_capabilities":["renderer","decoder"]},"supported_formats":"176400/24/2,176400/16/2,192000/24/2,48000/24/2,24000/24/2,192000/16/2,32000/24/2,88200/16/2,44100/24/2,22050/24/2,96000/16/2,32000/16/2,24000/16/2,96000/24/2,44100/16/2,88200/24/2,22050/16/2,48000/16/2"},"source_selection":{"is_supported":true,"info":{}},"platform":{"uname":{"sysname":"Linux","version":"#1 SMP PREEMPT Wed Dec  6 14:07:18 UTC 2023","release":"6.4.0-01745-gf3c6ae6a62c2","nodename":"ExerciseRoomNODE-B8CA","machine":"aarch64"},"os":"linux"},"volume":{"is_supported":true,"info":{}}}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] GOT [3] {"status":"Success"}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] RAAT Session initialized in 313ms
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] SENT [2]{"request":"info"}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
03/26 09:47:56 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] RAAT Session initialized in 316ms
03/26 09:47:56 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] SENT [2]{"request":"info"}
03/26 09:47:56 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
03/26 09:47:56 Trace: [raat] [Bluesound N130 @ 10.0.1.174:45113] => Connected
03/26 09:47:56 Trace: [raat] [Bluesound N130 @ 10.0.1.174:45113] connected
03/26 09:47:56 Info: [transport] creating endpoint for raat device BluOS:90:56:82:41:b8:ca
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] SENT [4]{"request":"subscribe_transport"}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"27250a6d-660b-458b-af45-9e8967d8beef"}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] GOT [2] {"flags":{"has_write_chmap":true},"info":{"unique_id":"BluOS:90:56:82:43:6f:f2"},"volume":{"is_supported":true,"info":{}},"platform":{"os":"linux","uname":{"nodename":"MasterBathNode","sysname":"Linux","machine":"aarch64","version":"#1 SMP PREEMPT Wed Dec  6 14:07:18 UTC 2023","release":"6.4.0-01745-gf3c6ae6a62c2"}},"transport":{"is_update_artwork_supported":true,"info":{},"is_supported":true,"is_update_status_supported":true},"source_selection":{"is_supported":true,"info":{}},"status":"Success","output":{"supported_formats":"22050/16/2,88200/24/2,32000/16/2,44100/16/2,32000/24/2,176400/24/2,24000/24/2,48000/24/2,88200/16/2,44100/24/2,192000/24/2,192000/16/2,48000/16/2,22050/24/2,24000/16/2,176400/16/2,96000/24/2,96000/16/2","info":{"mqa_capabilities":["renderer","decoder"]}}}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] GOT [5] {"status":"Success","controls":{"source":{"value":"not_selected","info":{}},"volume":{"type":"number","min":0.0,"value":33,"step":1.0,"info":{},"max":100.0,"mute":false}},"action":"Changed"}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] GOT [3] {"status":"Success"}
03/26 09:47:56 Trace: [dspengine] loaded DSP config {"version":3,"items":[{"type":"bs2b","enabled":false},{"type":"parametric_equalizer","enabled":false,"bands":[{"type":"low_shelf","frequency":43,"gain_db":9,"q":0.5,"is_enabled":true},{"type":"equalize_frequency","frequency":67,"gain_db":0,"q":0.5,"is_enabled":true},{"type":"high_shelf","frequency":8000,"gain_db":3,"q":0.5,"is_enabled":true},{"type":"equalize_frequency","frequency":2000,"gain_db":0,"q":1,"is_enabled":false},{"type":"high_shelf","frequency":5687,"gain_db":9.700000000000001,"q":0.3,"is_enabled":false},{"type":"high_pass","frequency":20,"order":1,"is_enabled":false},{"type":"low_pass","frequency":20000,"order":1,"is_enabled":false}],"gain_db":-4.2,"y_axis_min_db":-12,"y_axis_max_db":12},{"type":"audeze_presets","enabled":false}],"headroom_adjustment":{"type":"headroom_adjustment"},"sample_rate_conversion":{"type":"sample_rate_conversion"}}
03/26 09:47:56 Trace: [transport/audeze] picking preset lowlatency 
03/26 09:47:56 Trace: [transport/audeze] picked null preset!
03/26 09:47:56 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] GOT [2] {"platform":{"uname":{"sysname":"Linux","nodename":"localhost","machine":"armv8l","version":"#184 SMP PREEMPT Fri Feb 2 10:36:49 KST 2024","release":"4.4.83"},"os":"android"},"flags":{"has_write_chmap":true},"transport":{"is_supported":true,"is_update_artwork_supported":true,"info":{"config":{"type":"rose"}},"is_update_status_supported":true},"info":{"unique_id":"HiFiROSE:D0EB9E0D248B"},"output":{"info":{"config":{"replay_gain":0,"type":"rose","rose_dsd_mode":1,"disable_usb_hw_info":false,"skip_startup_device_check":true,"resync_delay":0.2,"card_type":3,"info":"Rose RS201","android_bits":32,"buffer_duration":0.04,"device":"hw:3,0","android_sample_rate":96000,"card_num":3,"mfr_type":3,"dsd_mode":"dop","device_num":0,"rose_model_id":8},"mqa_capabilities":["decoder","renderer"]},"supported_formats":"384000/16/1|2,384000/32/1|2,11289600/1/1|2,352800/32/1|2,192000/24/1|2,705600/16/1|2,48000/32/1|2,88200/24/1|2,88200/16/1|2,96000/32/1|2,352800/16/1|2,44100/24/1|2,88200/32/1|2,2822400/1/1|2,96000/24/1|2,352800/24/1|2,705600/32/1|2,96000/16/1|2,44100/16/1|2,48000/24/1|2,5644800/1/1|2,192000/32/1|2,176400/32/1|2,768000/32/1|2,705600/24/1|2,176400/16/1|2,384000/24/1|2,768000/16/1|2,192000/16/1|2,768000/24/1|2,48000/16/1|2,176400/24/1|2,44100/32/1|2"},"volume":{"is_supported":true,"info":{"config":{"name":"Rose Volume Control","type":"rose","card_num":3,"device_num":0,"card_type":3}}},"source_selection":{"is_supported":true,"info":{"config":{"type":"rose"}}},"status":"Success"}
03/26 09:47:56 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] GOT [3] {"status":"Success"}
03/26 09:47:56 Info: Created Stub for 23:1:5f7c4f61-2300-19d6-dac9-cde741f3dff9
03/26 09:47:56 Trace: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] Loading from /Users/jason/Library/RoonServer/Database/Core/324e013fcbcc4174b66215e1932c6442/transport/zone_1601bd20bcb23792f844ab2b9b464d37dc10.db
03/26 09:47:56 Trace: [library] endmutation in 23ms
03/26 09:47:56 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [2] {"volume":{"info":{"config":{"current":16,"maximum":100,"minimum":0,"mute":false,"disabled":false}},"is_supported":true},"output":{"supported_formats":"44100/24/1|2,384000/16/1|2,2822400/1/1|2,96000/16/1|2,88200/24/1|2,192000/16/1|2,48000/16/1|2,11289600/1/1|2,192000/32/1|2,176400/32/1|2,88200/32/1|2,352800/16/1|2,44100/32/1|2,352800/24/1|2,352800/32/1|2,96000/32/1|2,384000/24/1|2,88200/16/1|2,48000/24/1|2,96000/24/1|2,44100/16/1|2,384000/32/1|2,5644800/1/1|2,176400/16/1|2,48000/32/1|2,192000/24/1|2,176400/24/1|2","info":{"config":{"mqa_support":true,"max_pcm_rate":384000,"signal_path":[{"method":"analog","quality":"lossless","type":"amplifier"},{"method":"speakers","quality":"lossless","type":"output"}],"buffer_duration":0.1,"dsd_mode":"native","skip_startup_device_check":true,"sync_offset_ns":[{"offset":5000000,"sample_rate":44100},{"offset":5000000,"sample_rate":48000},{"offset":6000000,"sample_rate":88200},{"offset":7000000,"sample_rate":96000},{"offset":6000000,"sample_rate":176400},{"offset":5000000,"sample_rate":192000},{"offset":5000000,"sample_rate":352800},{"offset":5000000,"sample_rate":384000},{"offset":7000000,"sample_rate":2822400},{"offset":7000000,"sample_rate":5644800},{"offset":7000000,"sample_rate":11289600}],"supported_formats":[{"sample_type":"pcm","sample_rate":44100,"channels":1,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":44100,"channels":2,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":44100,"channels":1,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":44100,"channels":2,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":44100,"channels":1,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":44100,"channels":2,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":48000,"channels":1,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":48000,"channels":2,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":48000,"channels":1,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":48000,"channels":2,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":48000,"channels":1,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":48000,"channels":2,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":88200,"channels":1,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":88200,"channels":2,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":88200,"channels":1,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":88200,"channels":2,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":88200,"channels":1,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":88200,"channels":2,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":96000,"channels":1,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":96000,"channels":2,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":96000,"channels":1,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":96000,"channels":2,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":96000,"channels":1,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":96000,"channels":2,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":176400,"channels":1,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":176400,"channels":2,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":176400,"channels":1,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":176400,"channels":2,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":176400,"channels":1,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":176400,"channels":2,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":192000,"channels":1,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":192000,"channels":2,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":192000,"channels":1,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":192000,"channels":2,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":192000,"channels":1,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":192000,"channels":2,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":352800,"channels":1,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":352800,"channels":2,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":352800,"channels":1,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":352800,"channels":2,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":352800,"channels":1,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":352800,"channels":2,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":384000,"channels":1,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":384000,"channels":2,"bits_per_sample":16},{"sample_type":"pcm","sample_rate":384000,"channels":1,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":384000,"channels":2,"bits_per_sample":24},{"sample_type":"pcm","sample_rate":384000,"channels":1,"bits_per_sample":32},{"sample_type":"pcm","sample_rate":384000,"channels":2,"bits_per_sample":32},{"sample_type":"dsd","sample_rate":2822400,"channels":1,"bits_per_sample":1},{"sample_type":"dsd","sample_rate":2822400,"channels":2,"bits_per_sample":1},{"sample_type":"dsd","sample_rate":5644800,"channels":1,"bits_per_sample":1},{"sample_type":"dsd","sample_rate":5644800,"channels":2,"bits_per_sample":1},{"sample_type":"dsd","sample_rate":11289600,"channels":1,"bits_per_sample":1},{"sample_type":"dsd","sample_rate":11289600,"channels":2,"bits_per_sample":1}],"max_dsd_rate":256,"device":"default","resync_delay":0.5},"mqa_capabilities":["decoder","renderer"]}},"status":"Success","flags":{"has_write_chmap":true},"transport":{"is_update_status_supported":true,"is_update_artwork_supported":true,"info":{"config":{}},"is_supported":true},"platform":{"os":"linux","uname":{"release":"5.15.71-lts-5.15.y","version":"#1 SMP PREEMPT Fri Feb 9 11:56:41 UTC 2024","sysname":"Linux","machine":"aarch64","nodename":"Library-Evo-150"}},"info":{"unique_id":"CambridgeAudio:0040542d"},"source_selection":{"info":{"config":{"state":"standby"}},"is_supported":true}}
03/26 09:47:56 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [3] {"status":"Success"}
03/26 09:47:56 Trace: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] Suspend
03/26 09:47:56 Info: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] Canceling Pending Sleep
03/26 09:47:56 Trace: [Exercise Room NODE - B8CA] [zoneplayer/raat] Endpoint Bluesound NODE Initial State: Idle
03/26 09:47:56 Trace: [library] endmutation in 24ms
03/26 09:47:56 Info: [transport] created zone Bluesound PULSE 2i + Exercise Room NODE - B8CA
03/26 09:47:56 Info: [transport]     with endpoint Bluesound PULSE 2i (23:1:5f7c4f61-2300-19d6-dac9-cde741f3dff9) [IsAvailable=False]
03/26 09:47:56 Info: [transport]     with endpoint Bluesound NODE (23:1:c7032a6b-1908-eead-1e47-656f36be7c27) [IsAvailable=True]
03/26 09:47:56 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] RAAT Session initialized in 423ms
03/26 09:47:56 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] SENT [2]{"request":"info"}
03/26 09:47:56 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
03/26 09:47:56 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] RAAT Session initialized in 418ms
03/26 09:47:56 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] SENT [2]{"request":"info"}
03/26 09:47:56 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] SENT [3]{"request":"set_client_type","client_type":"Roon"}
03/26 09:47:56 Trace: [raat] [Bluesound N130 @ 10.0.1.159:37841] => Connected
03/26 09:47:56 Trace: [raat] [Bluesound N130 @ 10.0.1.159:37841] connected
03/26 09:47:56 Info: [transport] creating endpoint for raat device BluOS:90:56:82:43:6f:f2
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] SENT [4]{"request":"subscribe_transport"}
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"27250a6d-660b-458b-af45-9e8967d8beef"}
03/26 09:47:56 Trace: [dspengine] created new dsp config {"version":3,"items":[{"type":"bs2b","enabled":false},{"type":"parametric_equalizer","enabled":false},{"type":"audeze_presets","enabled":false}]}
03/26 09:47:56 Trace: [transport/audeze] picking preset lowlatency 
03/26 09:47:56 Trace: [transport/audeze] picked null preset!
03/26 09:47:56 Trace: [zone Master Bath Node] Loading from /Users/jason/Library/RoonServer/Database/Core/324e013fcbcc4174b66215e1932c6442/transport/zone_1601c8830530f0ee5bff9ae42559d7143172.db
03/26 09:47:56 Trace: [library] endmutation in 38ms
03/26 09:47:56 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] GOT [5] {"controls":{"source":{"info":{},"value":"not_selected"},"volume":{"mute":false,"value":97,"step":1.0,"info":{},"type":"number","max":100.0,"min":0.0}},"status":"Success","action":"Changed"}
03/26 09:47:56 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] GOT [2] {"transport":{"info":{},"is_supported":true,"is_update_status_supported":true,"is_update_artwork_supported":true},"info":{"unique_id":"BluOS:90:56:82:9f:97:27"},"flags":{"has_write_chmap":true},"platform":{"uname":{"version":"#1 SMP PREEMPT Wed Nov 15 19:36:37 UTC 2023","sysname":"Linux","nodename":"PULSE2i-9727","release":"6.4.0-01742-g13af13e216f7","machine":"armv7l"},"os":"linux"},"source_selection":{"info":{},"is_supported":true},"status":"Success","volume":{"info":{},"is_supported":true},"output":{"info":{"mqa_capabilities":["decoder"]},"supported_formats":"32000/16/2,24000/16/2,192000/24/2,176400/16/2,48000/16/2,192000/16/2,44100/16/2,88200/24/2,22050/24/2,88200/16/2,176400/24/2,48000/24/2,22050/16/2,96000/24/2,96000/16/2,44100/24/2,24000/24/2,32000/24/2"}}
03/26 09:47:56 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] GOT [3] {"status":"Success"}
03/26 09:47:56 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] GOT [2] {"source_selection":{"info":{},"is_supported":true},"flags":{"has_write_chmap":true},"info":{"unique_id":"BluOS:90:56:82:80:5b:32"},"output":{"supported_formats":"24000/16/2,48000/16/2,176400/16/2,22050/16/2,32000/24/2,44100/16/2,96000/16/2,88200/24/2,24000/24/2,88200/16/2,192000/24/2,22050/24/2,192000/16/2,48000/24/2,176400/24/2,44100/24/2,32000/16/2,96000/24/2","info":{"mqa_capabilities":["renderer","decoder"]}},"transport":{"is_update_status_supported":true,"info":{},"is_update_artwork_supported":true,"is_supported":true},"status":"Success","volume":{"info":{},"is_supported":true},"platform":{"os":"linux","uname":{"release":"6.4.0-01745-gf3c6ae6a62c2","nodename":"JasonsPOWERNODE-5B32","machine":"aarch64","sysname":"Linux","version":"#1 SMP PREEMPT Wed Dec  6 14:07:18 UTC 2023"}}}
03/26 09:47:56 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] GOT [3] {"status":"Success"}
03/26 09:47:56 Trace: [zone Master Bath Node] Suspend
03/26 09:47:56 Info: [zone Master Bath Node] Canceling Pending Sleep
03/26 09:47:56 Trace: [Master Bath Node] [zoneplayer/raat] Endpoint Bluesound NODE Initial State: Idle
03/26 09:47:56 Info: [transport] created zone Master Bath Node
03/26 09:47:56 Info: [transport]     with endpoint Bluesound NODE (23:1:300583c8-eef0-ff5b-9ae4-2559d7143172) [IsAvailable=True]
03/26 09:47:56 Trace: [Master Bath Node] [Lossless, 16/44 FLAC => 16/44] [100% buf] [STOPPED @ 0:00] 
03/26 09:47:56 Trace: [raat] [Rose RS520 @ 10.0.1.3:45865] => Connected
03/26 09:47:56 Trace: [raat] [Rose RS520 @ 10.0.1.3:45865] connected
03/26 09:47:56 Info: [transport] creating endpoint for raat device HiFiROSE:D0EB9E0D248B
03/26 09:47:56 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] SENT [4]{"request":"subscribe_transport"}
03/26 09:47:56 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"27250a6d-660b-458b-af45-9e8967d8beef"}
03/26 09:47:56 Trace: [dspengine] loaded DSP config {"version":3,"items":[{"type":"bs2b","enabled":false},{"type":"parametric_equalizer","enabled":true,"bands":[{"type":"low_shelf","frequency":63,"gain_db":9,"q":0.8,"is_enabled":true},{"type":"equalize_frequency","frequency":200,"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":2000,"gain_db":0,"q":1,"is_enabled":true},{"type":"high_shelf","frequency":6000,"gain_db":0,"q":1,"is_enabled":true},{"type":"high_pass","frequency":20,"order":1,"is_enabled":false},{"type":"low_pass","frequency":20000,"order":1,"is_enabled":false}],"gain_db":-6.300000000000001,"y_axis_min_db":-24,"y_axis_max_db":12},{"type":"audeze_presets","enabled":false}],"headroom_adjustment":{"type":"headroom_adjustment"},"sample_rate_conversion":{"type":"sample_rate_conversion"}}
03/26 09:47:56 Trace: [transport/audeze] picking preset lowlatency 
03/26 09:47:56 Trace: [transport/audeze] picked null preset!
03/26 09:47:56 Trace: [zone Kitchen] Loading from /Users/jason/Library/RoonServer/Database/Core/324e013fcbcc4174b66215e1932c6442/transport/zone_160106d77f841debaa361a0d29da33dea7cf.db
03/26 09:47:56 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] GOT [5] {"controls":{"source":{"is_standby_supported":true,"info":{"config":{"type":"rose"}},"value":"standby"},"volume":{"step":1.0,"type":"number","max":99.0,"min":0.0,"mute":false,"info":{"config":{"name":"Rose Volume Control","type":"rose","card_num":3,"device_num":0,"card_type":3}},"value":25}},"action":"Changed","status":"Success"}
03/26 09:47:56 Trace: [zone Kitchen] Suspend
03/26 09:47:56 Info: [zone Kitchen] Canceling Pending Sleep
03/26 09:47:56 Trace: [Kitchen] [zoneplayer/raat] Endpoint Rose RS520 Initial State: Idle
03/26 09:47:56 Info: [transport] created zone Kitchen
03/26 09:47:56 Info: [transport]     with endpoint Rose RS520 (23:1:847fd706-eb1d-36aa-1a0d-29da33dea7cf) [IsAvailable=True]
03/26 09:47:56 Trace: [Kitchen] [Enhanced, 16/44 ALAC => 32/44] [100% buf] [STOPPED @ 0:00] 
03/26 09:47:56 Trace: [raat] [Cambridge Audio Evo 150 @ 10.0.1.2:45515] => Connected
03/26 09:47:56 Trace: [raat] [Cambridge Audio Evo 150 @ 10.0.1.2:45515] connected
03/26 09:47:56 Info: [transport] creating endpoint for raat device CambridgeAudio:0040542d
03/26 09:47:56 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] SENT [4]{"request":"subscribe_transport"}
03/26 09:47:56 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"27250a6d-660b-458b-af45-9e8967d8beef"}
03/26 09:47:56 Trace: [dspengine] created new dsp config {"version":3,"items":[{"type":"bs2b","enabled":false},{"type":"parametric_equalizer","enabled":false},{"type":"audeze_presets","enabled":false}]}
03/26 09:47:56 Trace: [transport/audeze] picking preset lowlatency 
03/26 09:47:56 Trace: [transport/audeze] picked null preset!
03/26 09:47:56 Trace: [zone Library Evo 150] Loading from /Users/jason/Library/RoonServer/Database/Core/324e013fcbcc4174b66215e1932c6442/transport/zone_16016601829c7ac1430d048e647160ab2435.db
03/26 09:47:56 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [5] {"controls":{"source":{"value":"selected","info":{"config":{"state":"standby"}},"is_standby_supported":true},"volume":{"type":"number","mute":false,"step":1.0,"max":100.0,"min":0.0,"value":11,"info":{"config":{"current":16,"maximum":100,"minimum":0,"mute":false,"disabled":false}}}},"status":"Success","action":"Changed"}
03/26 09:47:56 Trace: [zone Library Evo 150] Suspend
03/26 09:47:56 Info: [zone Library Evo 150] Canceling Pending Sleep
03/26 09:47:56 Trace: [Library Evo 150] [zoneplayer/raat] Endpoint Cambridge Audio Evo 150 Initial State: Idle
03/26 09:47:56 Info: [transport] created zone Library Evo 150
03/26 09:47:56 Info: [transport]     with endpoint Cambridge Audio Evo 150 (23:1:9c820166-c17a-0d43-048e-647160ab2435) [IsAvailable=True]
03/26 09:47:56 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [STOPPED @ 0:00] 
03/26 09:47:56 Trace: [raat] [Bluesound PULSE 2i @ 10.0.1.190:36157] => Connected
03/26 09:47:56 Trace: [raat] [Bluesound PULSE 2i @ 10.0.1.190:36157] connected
03/26 09:47:56 Info: [transport] creating endpoint for raat device BluOS:90:56:82:9f:97:27
03/26 09:47:56 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] SENT [4]{"request":"subscribe_transport"}
03/26 09:47:56 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"27250a6d-660b-458b-af45-9e8967d8beef"}
03/26 09:47:56 Trace: [dspengine] loaded DSP config {"version":3,"items":[{"type":"bs2b","enabled":false},{"type":"parametric_equalizer","enabled":true,"bands":[{"type":"low_shelf","frequency":63,"gain_db":6,"q":0.7,"is_enabled":true},{"type":"equalize_frequency","frequency":200,"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":2000,"gain_db":0,"q":1,"is_enabled":true},{"type":"high_shelf","frequency":16000,"gain_db":3,"q":0.5,"is_enabled":true},{"type":"high_pass","frequency":20,"order":1,"is_enabled":false},{"type":"low_pass","frequency":20000,"order":1,"is_enabled":false}],"gain_db":0,"y_axis_min_db":-24,"y_axis_max_db":12},{"type":"audeze_presets","enabled":false}],"headroom_adjustment":{"type":"headroom_adjustment"},"sample_rate_conversion":{"type":"sample_rate_conversion"}}
03/26 09:47:56 Trace: [transport/audeze] picking preset lowlatency 
03/26 09:47:56 Trace: [transport/audeze] picked null preset!
03/26 09:47:56 Info: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] [zone] Zone PULSE 2i - 9727 + Exercise Room NODE - B8CA adding endpoint Bluesound PULSE 2i (23:1:5f7c4f61-2300-19d6-dac9-cde741f3dff9) [IsAvailable=True]
03/26 09:47:56 Trace: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] Suspend
03/26 09:47:56 Info: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] Canceling Pending Sleep
03/26 09:47:56 Trace: [PULSE 2i - 9727 + Exercise Room NODE - B8CA] [zoneplayer/raat] Endpoint Bluesound PULSE 2i Initial State: Idle
03/26 09:47:56 Trace: [PULSE 2i - 9727 + Exercise Room NODE - B8CA] [zoneplayer/raat] Endpoint Bluesound NODE Initial State: Idle
03/26 09:47:56 Trace: [raat] [Bluesound N330 @ 10.0.1.185:41945] => Connected
03/26 09:47:56 Trace: [raat] [Bluesound N330 @ 10.0.1.185:41945] connected
03/26 09:47:56 Info: [transport] creating endpoint for raat device BluOS:90:56:82:80:5b:32
03/26 09:47:56 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] SENT [4]{"request":"subscribe_transport"}
03/26 09:47:56 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] SENT [5]{"request":"subscribe_controls","controller_id":"27250a6d-660b-458b-af45-9e8967d8beef"}
03/26 09:47:56 Trace: [dspengine] loaded DSP config {"version":3,"items":[{"type":"bs2b","enabled":false},{"type":"parametric_equalizer","enabled":true,"bands":[{"type":"low_shelf","frequency":43,"gain_db":9,"q":0.7,"is_enabled":true},{"type":"equalize_frequency","frequency":200,"gain_db":0,"q":1,"is_enabled":false},{"type":"equalize_frequency","frequency":1000,"gain_db":0,"q":1,"is_enabled":false},{"type":"equalize_frequency","frequency":2000,"gain_db":0,"q":1,"is_enabled":false},{"type":"high_shelf","frequency":16000,"gain_db":4.5,"q":0.6,"is_enabled":true},{"type":"high_pass","frequency":20,"order":1,"is_enabled":false},{"type":"low_pass","frequency":20000,"order":1,"is_enabled":false}],"gain_db":-6,"y_axis_min_db":-12,"y_axis_max_db":12},{"type":"audeze_presets","enabled":false}],"headroom_adjustment":{"type":"headroom_adjustment"},"sample_rate_conversion":{"type":"sample_rate_conversion"}}
03/26 09:47:56 Trace: [transport/audeze] picking preset lowlatency 
03/26 09:47:56 Trace: [transport/audeze] picked null preset!
03/26 09:47:56 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] GOT [5] {"status":"Success","action":"Changed","controls":{"volume":{"max":100.0,"type":"number","value":29,"step":1.0,"mute":false,"info":{},"min":0.0},"source":{"value":"standby","info":{}}}}
03/26 09:47:56 Trace: [zone Jason’s POWERNODE - 5B32] Loading from /Users/jason/Library/RoonServer/Database/Core/324e013fcbcc4174b66215e1932c6442/transport/zone_16011e7ae3427fb8ccbc4d6c1eaca32dfe61.db
03/26 09:47:56 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] GOT [5] {"status":"Success","action":"Changed","controls":{"volume":{"type":"number","step":1.0,"mute":false,"min":0.0,"info":{},"value":5,"max":100.0},"source":{"info":{},"value":"standby"}}}
03/26 09:47:56 Trace: [zone Jason’s POWERNODE - 5B32] Suspend
03/26 09:47:56 Info: [zone Jason’s POWERNODE - 5B32] Canceling Pending Sleep
03/26 09:47:56 Trace: [Jason’s POWERNODE - 5B32] [zoneplayer/raat] Endpoint Bluesound POWERNODE Initial State: Idle
03/26 09:47:56 Info: [transport] created zone Jason’s POWERNODE - 5B32
03/26 09:47:56 Info: [transport]     with endpoint Bluesound POWERNODE (23:1:42e37a1e-b87f-bccc-4d6c-1eaca32dfe61) [IsAvailable=True]
03/26 09:47:56 Trace: [Jason’s POWERNODE - 5B32] [Enhanced, 16/44 FLAC => 24/44] [100% buf] [STOPPED @ 0:00] 
03/26 09:47:56 Trace: [library] endmutation in 23ms
03/26 09:47:56 Debug: [easyhttp] [24651] POST to https://www.qobuz.com/api.json/0.2/track/reportStreamingEnd? returned after 1069 ms, status code: 200, request body size: 359 B
03/26 09:47:56 Trace: [library] endmutation in 26ms
03/26 09:47:57 Trace: [library] endmutation in 24ms
03/26 09:47:57 Debug: [easyhttp] [24650] GET to https://www.qobuz.com/api.json/0.2/user/login?request_sig=44646ad65f3281bbccf5e812ca7a7796&request_ts=1711460863 returned after 1318 ms, status code: 200, request body size: 0 B
03/26 09:47:57 Trace: [library] endmutation in 23ms
03/26 09:47:57 Trace: [library] endmutation in 25ms
03/26 09:47:57 Trace: [library] endmutation in 23ms
03/26 09:47:57 Trace: [library] endmutation in 24ms
03/26 09:47:57 Trace: [library] endmutation in 25ms
03/26 09:47:57 Trace: [library] endmutation in 28ms
03/26 09:47:57 Trace: [library] endmutation in 28ms
03/26 09:47:57 Trace: [library] endmutation in 25ms
03/26 09:47:58 Trace: [library] endmutation in 28ms
03/26 09:47:58 Trace: [library] endmutation in 23ms
03/26 09:47:58 Trace: [library] endmutation in 24ms
03/26 09:47:58 Trace: [library] endmutation in 37ms
03/26 09:47:58 Trace: [library] endmutation in 22ms
03/26 09:47:58 Trace: [library] endmutation in 27ms
03/26 09:47:58 Trace: [library] endmutation in 22ms
03/26 09:47:58 Trace: [library] endmutation in 28ms
03/26 09:47:58 Trace: [library] endmutation in 28ms
03/26 09:47:58 Trace: [library] endmutation in 24ms
03/26 09:47:58 Trace: [library] endmutation in 24ms
03/26 09:47:58 Trace: [library] endmutation in 28ms
03/26 09:47:58 Trace: [library] endmutation in 33ms
03/26 09:47:59 Trace: [library] endmutation in 31ms
03/26 09:47:59 Trace: [library] endmutation in 21ms
03/26 09:47:59 Trace: [library] endmutation in 27ms
03/26 09:47:59 Trace: [library] endmutation in 21ms
03/26 09:47:59 Trace: [library] endmutation in 30ms
03/26 09:47:59 Trace: [library] endmutation in 28ms
03/26 09:47:59 Trace: [library] endmutation in 21ms
03/26 09:47:59 Trace: [library] endmutation in 20ms
03/26 09:47:59 Trace: [library] endmutation in 26ms
03/26 09:47:59 Trace: [library] endmutation in 20ms
03/26 09:48:00 Trace: [library] endmutation in 17ms
03/26 09:48:00 Trace: [library] endmutation in 17ms
03/26 09:48:00 Trace: [library] endmutation in 16ms
03/26 09:48:00 Trace: [library] endmutation in 23ms
03/26 09:48:00 Trace: [library] endmutation in 25ms
03/26 09:48:00 Trace: [library] endmutation in 18ms
03/26 09:48:00 Trace: [library] endmutation in 17ms
03/26 09:48:00 Trace: [library] endmutation in 13ms
03/26 09:48:00 Trace: [library] endmutation in 19ms
03/26 09:48:00 Trace: [library] endmutation in 19ms
03/26 09:48:00 Trace: [library] endmutation in 27ms
03/26 09:48:00 Trace: [library] endmutation in 21ms
03/26 09:48:00 Trace: [library] endmutation in 22ms
03/26 09:48:00 Trace: [library] endmutation in 20ms
03/26 09:48:00 Trace: [library] endmutation in 24ms
03/26 09:48:00 Trace: [library] endmutation in 19ms
03/26 09:48:00 Trace: [library] endmutation in 24ms
03/26 09:48:01 Trace: [library] endmutation in 20ms
03/26 09:48:01 Trace: [library] endmutation in 24ms
03/26 09:48:01 Trace: [library] endmutation in 22ms
03/26 09:48:01 Trace: [library] endmutation in 24ms
03/26 09:48:01 Trace: [library] endmutation in 26ms
03/26 09:48:01 Trace: [library] endmutation in 23ms
03/26 09:48:01 Trace: [library] endmutation in 22ms
03/26 09:48:01 Trace: [library] endmutation in 27ms
03/26 09:48:01 Trace: [library] endmutation in 24ms
03/26 09:48:01 Trace: [library] endmutation in 24ms
03/26 09:48:01 Trace: [library] endmutation in 21ms
03/26 09:48:02 Trace: [library] endmutation in 21ms
03/26 09:48:02 Trace: [library] endmutation in 13ms
03/26 09:48:02 Trace: [library] endmutation in 14ms
03/26 09:48:03 Trace: [library] endmutation in 16ms
03/26 09:48:03 Trace: [library] endmutation in 20ms
03/26 09:48:03 Trace: [library] endmutation in 23ms
03/26 09:48:03 Trace: [library] endmutation in 19ms
03/26 09:48:03 Trace: [library] endmutation in 23ms
03/26 09:48:03 Trace: [library] endmutation in 17ms
03/26 09:48:03 Trace: [library] endmutation in 18ms
03/26 09:48:03 Trace: [library] endmutation in 24ms
03/26 09:48:04 Trace: [library] endmutation in 23ms
03/26 09:48:05 Info: [stats] 415778mb Virtual, 6201mb Physical, 6700mb Managed
03/26 09:48:05 Trace: [library] endmutation in 21ms
03/26 09:48:05 Trace: [library] endmutation in 20ms
03/26 09:48:05 Trace: [library] endmutation in 20ms
03/26 09:48:06 Trace: [library] endmutation in 24ms
03/26 09:48:06 Trace: [library] endmutation in 31ms
03/26 09:48:06 Trace: [library] endmutation in 20ms
03/26 09:48:06 Trace: [library] endmutation in 20ms
03/26 09:48:06 Trace: [library] endmutation in 27ms
03/26 09:48:06 Trace: [library] endmutation in 17ms
03/26 09:48:06 Trace: [library] endmutation in 17ms
03/26 09:48:06 Trace: [library] endmutation in 12ms
03/26 09:48:06 Trace: [library] endmutation in 24ms
03/26 09:48:06 Trace: [library] endmutation in 21ms
03/26 09:48:06 Trace: [library] endmutation in 19ms
03/26 09:48:06 Debug: [easyhttp] [24652] POST to https://api.roonlabs.net/device-map/1/register returned after 284 ms, status code: 200, request body size: 9 KB
03/26 09:48:06 Trace: [devicemap] device map updated
03/26 09:48:06 Trace: [library] endmutation in 29ms
03/26 09:48:07 Trace: [library] endmutation in 25ms
03/26 09:48:07 Trace: [library] endmutation in 22ms
03/26 09:48:07 Trace: [library] endmutation in 22ms
03/26 09:48:07 Trace: [library] endmutation in 41ms
03/26 09:48:07 Trace: [library] endmutation in 32ms
03/26 09:48:08 Trace: [library] endmutation in 20ms
03/26 09:48:08 Trace: [library] endmutation in 22ms
03/26 09:48:08 Trace: [library] endmutation in 23ms
03/26 09:48:08 Trace: [library] endmutation in 46ms
03/26 09:48:08 Trace: [library] endmutation in 21ms
03/26 09:48:08 Trace: [library] endmutation in 27ms
03/26 09:48:08 Trace: [library] endmutation in 23ms
03/26 09:48:08 Trace: [library] endmutation in 23ms
03/26 09:48:08 Trace: [library] endmutation in 23ms
03/26 09:48:08 Trace: [library] endmutation in 33ms
03/26 09:48:08 Trace: [library] endmutation in 21ms
03/26 09:48:09 Trace: [library] endmutation in 28ms
03/26 09:48:09 Trace: [library] endmutation in 22ms
03/26 09:48:09 Trace: [library] endmutation in 35ms
03/26 09:48:09 Trace: [library] endmutation in 38ms
03/26 09:48:09 Trace: [library] endmutation in 26ms
03/26 09:48:09 Trace: [library] endmutation in 21ms
03/26 09:48:09 Trace: [library] endmutation in 20ms
03/26 09:48:09 Trace: [library] endmutation in 22ms
03/26 09:48:09 Trace: [library] endmutation in 23ms
03/26 09:48:09 Trace: [library] endmutation in 24ms
03/26 09:48:10 Trace: [library] endmutation in 24ms
03/26 09:48:10 Trace: [library] endmutation in 33ms
03/26 09:48:10 Trace: [library] endmutation in 22ms
03/26 09:48:10 Trace: [library] endmutation in 22ms
03/26 09:48:10 Trace: [library] endmutation in 27ms
03/26 09:48:10 Trace: [library] endmutation in 20ms
03/26 09:48:10 Trace: [library] endmutation in 24ms
03/26 09:48:10 Trace: [library] endmutation in 24ms
03/26 09:48:10 Trace: [library] endmutation in 22ms
03/26 09:48:10 Trace: [library] endmutation in 23ms
03/26 09:48:10 Trace: [library] endmutation in 28ms
03/26 09:48:10 Trace: [library] endmutation in 23ms
03/26 09:48:10 Trace: [library] endmutation in 23ms
03/26 09:48:10 Trace: [library] endmutation in 24ms
03/26 09:48:11 Trace: [library] endmutation in 32ms
03/26 09:48:11 Trace: [library] endmutation in 19ms
03/26 09:48:11 Trace: [library] endmutation in 24ms
03/26 09:48:11 Trace: [library] endmutation in 26ms
03/26 09:48:11 Trace: [library] endmutation in 21ms
03/26 09:48:11 Trace: [library] endmutation in 23ms
03/26 09:48:12 Trace: [library] endmutation in 22ms
03/26 09:48:12 Trace: [library] endmutation in 26ms
03/26 09:48:12 Trace: [library] endmutation in 20ms
03/26 09:48:12 Trace: [library] endmutation in 20ms
03/26 09:48:12 Trace: [library] endmutation in 22ms
03/26 09:48:12 Trace: [library] endmutation in 25ms
03/26 09:48:12 Trace: [library] endmutation in 20ms
03/26 09:48:12 Trace: [library] endmutation in 19ms
03/26 09:48:12 Trace: [library] endmutation in 19ms
03/26 09:48:12 Trace: [library] endmutation in 22ms
03/26 09:48:12 Trace: [library] endmutation in 21ms
03/26 09:48:13 Trace: [library] endmutation in 25ms
03/26 09:48:13 Trace: [library] endmutation in 19ms
03/26 09:48:13 Trace: [library] endmutation in 22ms
03/26 09:48:13 Trace: [library] endmutation in 22ms
03/26 09:48:13 Trace: [library] endmutation in 29ms
03/26 09:48:13 Trace: [library] endmutation in 19ms
03/26 09:48:13 Trace: [library] endmutation in 20ms
03/26 09:48:13 Trace: [library] endmutation in 22ms
03/26 09:48:13 Trace: [library] endmutation in 22ms
03/26 09:48:13 Trace: [library] endmutation in 23ms
03/26 09:48:13 Trace: [library] endmutation in 31ms
03/26 09:48:13 Trace: [library] endmutation in 20ms
03/26 09:48:13 Trace: [library] endmutation in 22ms
03/26 09:48:13 Trace: [library] endmutation in 22ms
03/26 09:48:13 Trace: [library] endmutation in 23ms
03/26 09:48:14 Trace: [library] endmutation in 21ms
03/26 09:48:14 Trace: [library] endmutation in 22ms
03/26 09:48:14 Trace: [library] endmutation in 23ms
03/26 09:48:14 Trace: [library] endmutation in 31ms
03/26 09:48:14 Trace: [library] endmutation in 19ms
03/26 09:48:14 Trace: [library] endmutation in 21ms
03/26 09:48:14 Trace: [library] endmutation in 22ms
03/26 09:48:14 Trace: [library] endmutation in 19ms
03/26 09:48:14 Trace: [library] endmutation in 19ms
03/26 09:48:14 Trace: [library] endmutation in 21ms
03/26 09:48:14 Trace: [library] endmutation in 21ms
03/26 09:48:14 Trace: [library] endmutation in 24ms
03/26 09:48:14 Trace: [library] endmutation in 22ms
03/26 09:48:14 Trace: [library] endmutation in 23ms
03/26 09:48:14 Trace: [library] endmutation in 23ms
03/26 09:48:15 Trace: [library] endmutation in 33ms
03/26 09:48:15 Trace: [library] endmutation in 26ms
03/26 09:48:15 Trace: [library] endmutation in 26ms
03/26 09:48:15 Trace: [library] endmutation in 21ms
03/26 09:48:15 Trace: [library] endmutation in 20ms
03/26 09:48:15 Trace: [library] endmutation in 18ms
03/26 09:48:15 Trace: [library] endmutation in 20ms
03/26 09:48:15 Trace: [library] endmutation in 19ms
03/26 09:48:15 Trace: [library] endmutation in 21ms
03/26 09:48:15 Trace: [library] endmutation in 21ms
03/26 09:48:15 Trace: [library] endmutation in 27ms
03/26 09:48:16 Trace: [library] endmutation in 18ms
03/26 09:48:16 Trace: [library] endmutation in 18ms
03/26 09:48:16 Trace: [library] endmutation in 24ms
03/26 09:48:16 Trace: [library] endmutation in 16ms
03/26 09:48:16 Trace: [library] endmutation in 21ms
03/26 09:48:16 Trace: [library] endmutation in 19ms
03/26 09:48:16 Trace: [library] endmutation in 19ms
03/26 09:48:16 Trace: [library] endmutation in 22ms
03/26 09:48:16 Trace: [library] endmutation in 18ms
03/26 09:48:16 Trace: [library] endmutation in 18ms
03/26 09:48:16 Trace: [library] endmutation in 16ms
03/26 09:48:16 Trace: [library] endmutation in 18ms
03/26 09:48:16 Trace: [library] endmutation in 17ms
03/26 09:48:16 Trace: [library] endmutation in 20ms
03/26 09:48:16 Trace: [library] endmutation in 17ms
03/26 09:48:16 Trace: [library] endmutation in 17ms
03/26 09:48:17 Trace: [library] endmutation in 18ms
03/26 09:48:17 Trace: [library] endmutation in 25ms
03/26 09:48:17 Trace: [library] endmutation in 17ms
03/26 09:48:17 Trace: [library] endmutation in 18ms
03/26 09:48:17 Trace: [library] endmutation in 18ms
03/26 09:48:17 Trace: [library] endmutation in 25ms
03/26 09:48:17 Trace: [library] endmutation in 13ms
03/26 09:48:17 Trace: [library] endmutation in 14ms
03/26 09:48:17 Trace: [library] endmutation in 17ms
03/26 09:48:17 Trace: [library] endmutation in 20ms
03/26 09:48:17 Trace: [library] endmutation in 16ms
03/26 09:48:17 Trace: [library] endmutation in 18ms
03/26 09:48:17 Trace: [library] endmutation in 24ms
03/26 09:48:17 Trace: [library] endmutation in 15ms
03/26 09:48:17 Trace: [library] endmutation in 17ms
03/26 09:48:17 Trace: [library] endmutation in 21ms
03/26 09:48:18 Trace: [library] endmutation in 17ms
03/26 09:48:18 Trace: [library] endmutation in 20ms
03/26 09:48:18 Trace: [library] endmutation in 14ms
03/26 09:48:18 Trace: [library] endmutation in 15ms
03/26 09:48:18 Trace: [library] endmutation in 17ms
03/26 09:48:18 Trace: [library] endmutation in 18ms
03/26 09:48:18 Trace: [library] endmutation in 18ms
03/26 09:48:18 Trace: [library] endmutation in 18ms
03/26 09:48:18 Trace: [library] endmutation in 18ms
03/26 09:48:18 Trace: [library] endmutation in 24ms
03/26 09:48:18 Trace: [library] endmutation in 17ms
03/26 09:48:18 Trace: [library] endmutation in 23ms
03/26 09:48:18 Trace: [library] endmutation in 19ms
03/26 09:48:18 Trace: [library] endmutation in 19ms
03/26 09:48:18 Trace: [library] endmutation in 25ms
03/26 09:48:18 Trace: [library] endmutation in 19ms
03/26 09:48:18 Trace: [library] endmutation in 19ms
03/26 09:48:18 Trace: [library] endmutation in 18ms
03/26 09:48:18 Trace: [library] endmutation in 22ms
03/26 09:48:19 Trace: [library] endmutation in 17ms
03/26 09:48:19 Trace: [library] endmutation in 18ms
03/26 09:48:19 Trace: [library] endmutation in 23ms
03/26 09:48:19 Trace: [library] endmutation in 18ms
03/26 09:48:19 Trace: [library] endmutation in 18ms
03/26 09:48:19 Trace: [library] endmutation in 18ms
03/26 09:48:19 Trace: [library] endmutation in 26ms
03/26 09:48:19 Trace: [library] endmutation in 17ms
03/26 09:48:19 Trace: [library] endmutation in 19ms
03/26 09:48:19 Trace: [library] endmutation in 23ms
03/26 09:48:19 Trace: [library] endmutation in 19ms
03/26 09:48:19 Trace: [library] endmutation in 19ms
03/26 09:48:19 Trace: [library] endmutation in 21ms
03/26 09:48:19 Trace: [library] endmutation in 19ms
03/26 09:48:19 Trace: [library] endmutation in 21ms
03/26 09:48:19 Trace: [library] endmutation in 21ms
03/26 09:48:19 Trace: [library] endmutation in 22ms
03/26 09:48:19 Trace: [library] endmutation in 28ms
03/26 09:48:20 Info: [stats] 415699mb Virtual, 6065mb Physical, 5897mb Managed
03/26 09:48:20 Trace: [library] endmutation in 18ms
03/26 09:48:20 Trace: [library] endmutation in 24ms
03/26 09:48:20 Trace: [library] endmutation in 19ms
03/26 09:48:20 Trace: [library] endmutation in 21ms
03/26 09:48:20 Trace: [library] endmutation in 21ms
03/26 09:48:20 Trace: [library] endmutation in 20ms
03/26 09:48:20 Trace: [library] endmutation in 26ms
03/26 09:48:20 Trace: [library] endmutation in 18ms
03/26 09:48:20 Trace: [library] endmutation in 21ms
03/26 09:48:20 Trace: [library] endmutation in 21ms
03/26 09:48:20 Trace: [library] endmutation in 20ms
03/26 09:48:20 Trace: [library] endmutation in 22ms
03/26 09:48:20 Trace: [library] endmutation in 20ms
03/26 09:48:20 Trace: [library] endmutation in 21ms
03/26 09:48:20 Trace: [library] endmutation in 22ms
03/26 09:48:21 Trace: [library] endmutation in 30ms
03/26 09:48:21 Trace: [library] endmutation in 20ms
03/26 09:48:21 Trace: [library] endmutation in 16ms
03/26 09:48:21 Trace: [library] endmutation in 20ms
03/26 09:48:21 Trace: [library] endmutation in 20ms
03/26 09:48:21 Trace: [library] endmutation in 28ms
03/26 09:48:21 Trace: [library] endmutation in 16ms
03/26 09:48:21 Trace: [library] endmutation in 21ms
03/26 09:48:21 Trace: [library] endmutation in 20ms
03/26 09:48:21 Debug: [easyhttp] [24653] POST to https://api.roonlabs.net/device-map/1/register returned after 299 ms, status code: 200, request body size: 9 KB
03/26 09:48:21 Trace: [devicemap] device map updated
03/26 09:48:22 Trace: [library] endmutation in 20ms
03/26 09:48:22 Trace: [library] endmutation in 16ms
03/26 09:48:22 Trace: [library] endmutation in 19ms
03/26 09:48:22 Trace: [library] endmutation in 24ms
03/26 09:48:22 Trace: [library] endmutation in 19ms
03/26 09:48:22 Trace: [library] endmutation in 21ms
03/26 09:48:22 Trace: [library] endmutation in 20ms
03/26 09:48:22 Trace: [library] endmutation in 24ms
03/26 09:48:23 Trace: [library] endmutation in 18ms
03/26 09:48:23 Trace: [library] endmutation in 17ms
03/26 09:48:23 Trace: [library] endmutation in 18ms
03/26 09:48:23 Trace: [library] endmutation in 18ms
03/26 09:48:23 Trace: [library] endmutation in 19ms
03/26 09:48:23 Trace: [library] endmutation in 19ms
03/26 09:48:23 Trace: [library] endmutation in 21ms
03/26 09:48:23 Trace: [library] endmutation in 17ms
03/26 09:48:23 Trace: [library] endmutation in 20ms
03/26 09:48:24 Trace: [library] endmutation in 19ms
03/26 09:48:24 Trace: [library] endmutation in 20ms
03/26 09:48:24 Trace: [library] endmutation in 20ms
03/26 09:48:24 Trace: [library] endmutation in 28ms
03/26 09:48:24 Trace: [library] endmutation in 17ms
03/26 09:48:24 Trace: [library] endmutation in 19ms
03/26 09:48:24 Trace: [library] endmutation in 21ms
03/26 09:48:24 Trace: [library] endmutation in 22ms
03/26 09:48:24 Trace: [library] endmutation in 28ms
03/26 09:48:24 Trace: [library] endmutation in 16ms
03/26 09:48:24 Trace: [library] endmutation in 18ms
03/26 09:48:24 Trace: [library] endmutation in 16ms
03/26 09:48:25 Trace: [library] endmutation in 19ms
03/26 09:48:25 Trace: [library] endmutation in 19ms
03/26 09:48:25 Trace: [library] endmutation in 26ms
03/26 09:48:25 Trace: [library] endmutation in 19ms
03/26 09:48:25 Trace: [library] endmutation in 19ms
03/26 09:48:25 Trace: [library] endmutation in 24ms
03/26 09:48:25 Trace: [library] endmutation in 18ms
03/26 09:48:26 Trace: [library] endmutation in 18ms
03/26 09:48:26 Trace: [library] endmutation in 15ms
03/26 09:48:26 Trace: [library] endmutation in 18ms
03/26 09:48:26 Trace: [library] endmutation in 20ms
03/26 09:48:26 Trace: [library] endmutation in 15ms
03/26 09:48:26 Trace: [library] endmutation in 19ms
03/26 09:48:26 Trace: [library] endmutation in 19ms
03/26 09:48:26 Trace: [library] endmutation in 20ms
03/26 09:48:26 Trace: [library] endmutation in 29ms
03/26 09:48:26 Trace: [library] endmutation in 17ms
03/26 09:48:26 Trace: [library] endmutation in 18ms
03/26 09:48:26 Trace: [library] endmutation in 17ms
03/26 09:48:26 Trace: [library] endmutation in 21ms
03/26 09:48:27 Trace: [library] endmutation in 17ms
03/26 09:48:27 Trace: [library] endmutation in 20ms
03/26 09:48:27 Trace: [library] endmutation in 19ms
03/26 09:48:27 Trace: [library] endmutation in 21ms
03/26 09:48:27 Trace: [library] endmutation in 18ms
03/26 09:48:27 Trace: [library] endmutation in 19ms
03/26 09:48:27 Trace: [library] endmutation in 18ms
03/26 09:48:27 Trace: [library] endmutation in 22ms
03/26 09:48:27 Trace: [library] endmutation in 19ms
03/26 09:48:27 Trace: [library] endmutation in 23ms
03/26 09:48:27 Trace: [library] endmutation in 15ms
03/26 09:48:27 Trace: [library] endmutation in 18ms
03/26 09:48:27 Trace: [library] endmutation in 19ms
03/26 09:48:27 Trace: [library] endmutation in 20ms
03/26 09:48:28 Trace: [library] endmutation in 20ms
03/26 09:48:28 Trace: [library] endmutation in 21ms
03/26 09:48:28 Trace: [library] endmutation in 21ms
03/26 09:48:28 Trace: [library] endmutation in 17ms
03/26 09:48:28 Trace: [library] endmutation in 16ms
03/26 09:48:28 Trace: [library] endmutation in 17ms
03/26 09:48:28 Trace: [library] endmutation in 18ms
03/26 09:48:28 Trace: [library] endmutation in 19ms
03/26 09:48:28 Trace: [library] endmutation in 19ms
03/26 09:48:28 Trace: [library] endmutation in 20ms
03/26 09:48:28 Trace: [library] endmutation in 24ms
03/26 09:48:28 Trace: [library] endmutation in 14ms
03/26 09:48:28 Trace: [library] endmutation in 18ms
03/26 09:48:28 Trace: [library] endmutation in 19ms
03/26 09:48:28 Trace: [library] endmutation in 25ms
03/26 09:48:28 Trace: [library] endmutation in 18ms
03/26 09:48:28 Trace: [library] endmutation in 18ms
03/26 09:48:28 Trace: [library] endmutation in 19ms
03/26 09:48:28 Trace: [library] endmutation in 26ms
03/26 09:48:28 Trace: [library] endmutation in 16ms
03/26 09:48:29 Trace: [library] endmutation in 20ms
03/26 09:48:29 Trace: [library] endmutation in 20ms
03/26 09:48:29 Trace: [library] endmutation in 16ms
03/26 09:48:29 Trace: [library] endmutation in 17ms
03/26 09:48:29 Trace: [library] endmutation in 18ms
03/26 09:48:29 Trace: [library] endmutation in 22ms
03/26 09:48:29 Trace: [library] endmutation in 17ms
03/26 09:48:29 Trace: [library] endmutation in 18ms
03/26 09:48:29 Trace: [library] endmutation in 20ms
03/26 09:48:29 Trace: [library] endmutation in 21ms
03/26 09:48:29 Trace: [library] endmutation in 21ms
03/26 09:48:29 Trace: [library] endmutation in 21ms
03/26 09:48:29 Trace: [library] endmutation in 24ms
03/26 09:48:29 Trace: [library] endmutation in 19ms
03/26 09:48:29 Trace: [library] endmutation in 20ms
03/26 09:48:30 Trace: [library] endmutation in 25ms
03/26 09:48:30 Trace: [library] endmutation in 14ms
03/26 09:48:30 Trace: [library] endmutation in 18ms
03/26 09:48:30 Trace: [library] endmutation in 23ms
03/26 09:48:30 Trace: [library] endmutation in 13ms
03/26 09:48:30 Trace: [library] endmutation in 21ms
03/26 09:48:30 Trace: [library] endmutation in 19ms
03/26 09:48:30 Trace: [library] endmutation in 23ms
03/26 09:48:30 Trace: [library] endmutation in 16ms
03/26 09:48:30 Trace: [library] endmutation in 21ms
03/26 09:48:30 Trace: [library] endmutation in 21ms
03/26 09:48:30 Trace: [library] endmutation in 14ms
03/26 09:48:30 Trace: [library] endmutation in 13ms
03/26 09:48:31 Trace: [library] endmutation in 22ms
03/26 09:48:31 Trace: [library] endmutation in 18ms
03/26 09:48:31 Trace: [library] endmutation in 18ms
03/26 09:48:31 Trace: [library] endmutation in 21ms
03/26 09:48:31 Trace: [library] endmutation in 18ms
03/26 09:48:31 Trace: [library] endmutation in 21ms
03/26 09:48:31 Trace: [library] endmutation in 27ms
03/26 09:48:31 Trace: [library] endmutation in 21ms
03/26 09:48:31 Trace: [library] endmutation in 22ms
03/26 09:48:31 Trace: [library] endmutation in 27ms
03/26 09:48:31 Trace: [library] endmutation in 21ms
03/26 09:48:31 Trace: [library] endmutation in 19ms
03/26 09:48:32 Trace: [library] endmutation in 18ms
03/26 09:48:32 Trace: [library] endmutation in 20ms
03/26 09:48:32 Trace: [library] endmutation in 20ms
03/26 09:48:32 Trace: [library] endmutation in 18ms
03/26 09:48:32 Trace: [library] endmutation in 20ms
03/26 09:48:32 Trace: [library] endmutation in 20ms
03/26 09:48:32 Trace: [library] endmutation in 25ms
03/26 09:48:32 Trace: [library] endmutation in 19ms
03/26 09:48:32 Trace: [library] endmutation in 20ms
03/26 09:48:32 Trace: [library] endmutation in 24ms
03/26 09:48:32 Trace: [library] endmutation in 17ms
03/26 09:48:32 Trace: [library] endmutation in 19ms
03/26 09:48:32 Trace: [library] endmutation in 20ms
03/26 09:48:32 Trace: [library] endmutation in 22ms
03/26 09:48:32 Trace: [library] endmutation in 20ms
03/26 09:48:32 Trace: [library] endmutation in 19ms
03/26 09:48:32 Trace: [library] endmutation in 21ms
03/26 09:48:33 Trace: [library] endmutation in 19ms
03/26 09:48:33 Trace: [library] endmutation in 19ms
03/26 09:48:33 Trace: [library] endmutation in 19ms
03/26 09:48:33 Trace: [library] endmutation in 18ms
03/26 09:48:33 Trace: [library] endmutation in 19ms
03/26 09:48:33 Trace: [library] endmutation in 19ms
03/26 09:48:33 Trace: [library] endmutation in 19ms
03/26 09:48:34 Trace: [library] endmutation in 19ms
03/26 09:48:34 Trace: [library] endmutation in 20ms
03/26 09:48:34 Trace: [library] endmutation in 20ms
03/26 09:48:34 Trace: [library] endmutation in 17ms
03/26 09:48:34 Trace: [library] endmutation in 20ms
03/26 09:48:34 Trace: [library] endmutation in 19ms
03/26 09:48:34 Trace: [library] endmutation in 23ms
03/26 09:48:34 Trace: [library] endmutation in 23ms
03/26 09:48:34 Trace: [library] endmutation in 14ms
03/26 09:48:35 Trace: [library] endmutation in 19ms
03/26 09:48:35 Trace: [library] endmutation in 20ms
03/26 09:48:35 Trace: [library] endmutation in 18ms
03/26 09:48:35 Info: [stats] 415700mb Virtual, 5173mb Physical, 6495mb Managed
03/26 09:48:35 Trace: [library] endmutation in 18ms
03/26 09:48:35 Trace: [library] endmutation in 19ms
03/26 09:48:35 Trace: [library] endmutation in 19ms
03/26 09:48:35 Trace: [library] endmutation in 26ms
03/26 09:48:35 Trace: [library] endmutation in 16ms
03/26 09:48:35 Trace: [library] endmutation in 19ms
03/26 09:48:35 Trace: [library] endmutation in 23ms
03/26 09:48:35 Trace: [library] endmutation in 17ms
03/26 09:48:35 Trace: [library] endmutation in 18ms
03/26 09:48:35 Trace: [library] endmutation in 19ms
03/26 09:48:35 Trace: [library] endmutation in 19ms
03/26 09:48:35 Trace: [library] endmutation in 19ms
03/26 09:48:35 Trace: [library] endmutation in 20ms
03/26 09:48:36 Trace: [library] endmutation in 20ms
03/26 09:48:36 Trace: [library] endmutation in 19ms
03/26 09:48:36 Trace: [library] endmutation in 19ms
03/26 09:48:36 Trace: [library] endmutation in 19ms
03/26 09:48:36 Trace: [library] endmutation in 19ms
03/26 09:48:36 Trace: [library] endmutation in 27ms
03/26 09:48:36 Trace: [library] endmutation in 16ms
03/26 09:48:36 Trace: [library] endmutation in 20ms
03/26 09:48:36 Trace: [library] endmutation in 20ms
03/26 09:48:36 Trace: [library] endmutation in 25ms
03/26 09:48:36 Trace: [library] endmutation in 17ms
03/26 09:48:36 Trace: [library] endmutation in 13ms
03/26 09:48:36 Trace: [library] endmutation in 15ms
03/26 09:48:36 Trace: [library] endmutation in 18ms
03/26 09:48:36 Trace: [library] endmutation in 19ms
03/26 09:48:36 Trace: [library] endmutation in 20ms
03/26 09:48:36 Trace: [library] endmutation in 26ms
03/26 09:48:36 Trace: [library] endmutation in 16ms
03/26 09:48:36 Trace: [library] endmutation in 17ms
03/26 09:48:36 Trace: [library] endmutation in 19ms
03/26 09:48:36 Trace: [library] endmutation in 20ms
03/26 09:48:36 Trace: [library] endmutation in 20ms
03/26 09:48:37 Trace: [library] endmutation in 19ms
03/26 09:48:37 Trace: [library] endmutation in 13ms
03/26 09:48:37 Trace: [library] endmutation in 18ms
03/26 09:48:37 Trace: [library] endmutation in 20ms
03/26 09:48:37 Trace: [library] endmutation in 20ms
03/26 09:48:37 Trace: [library] endmutation in 19ms
03/26 09:48:37 Trace: [library] endmutation in 13ms
03/26 09:48:37 Trace: [library] endmutation in 17ms
03/26 09:48:37 Trace: [library] endmutation in 17ms
03/26 09:48:37 Trace: [library] endmutation in 19ms
03/26 09:48:37 Trace: [library] endmutation in 20ms
03/26 09:48:37 Trace: [library] endmutation in 19ms
03/26 09:48:37 Trace: [library] endmutation in 19ms
03/26 09:48:37 Trace: [library] endmutation in 26ms
03/26 09:48:38 Trace: [library] endmutation in 18ms
03/26 09:48:38 Trace: [library] endmutation in 21ms
03/26 09:48:38 Trace: [library] endmutation in 13ms
03/26 09:48:38 Trace: [library] endmutation in 17ms
03/26 09:48:38 Trace: [library] endmutation in 18ms
03/26 09:48:38 Trace: [library] endmutation in 22ms
03/26 09:48:38 Trace: [library] endmutation in 17ms
03/26 09:48:38 Trace: [library] endmutation in 17ms
03/26 09:48:38 Trace: [library] endmutation in 12ms
03/26 09:48:38 Trace: [library] endmutation in 16ms
03/26 09:48:38 Trace: [library] endmutation in 17ms
03/26 09:48:38 Trace: [library] endmutation in 18ms
03/26 09:48:38 Trace: [library] endmutation in 24ms
03/26 09:48:38 Trace: [library] endmutation in 16ms
03/26 09:48:38 Trace: [library] endmutation in 15ms
03/26 09:48:38 Trace: [library] endmutation in 18ms
03/26 09:48:38 Trace: [library] endmutation in 20ms
03/26 09:48:39 Trace: [library] endmutation in 20ms
03/26 09:48:39 Trace: [library] endmutation in 27ms
03/26 09:48:39 Trace: [library] endmutation in 19ms
03/26 09:48:39 Trace: [library] endmutation in 19ms
03/26 09:48:39 Trace: [library] endmutation in 19ms
03/26 09:48:39 Trace: [library] endmutation in 26ms
03/26 09:48:39 Trace: [library] endmutation in 15ms
03/26 09:48:39 Trace: [library] endmutation in 16ms
03/26 09:48:39 Trace: [library] endmutation in 18ms
03/26 09:48:39 Trace: [library] endmutation in 18ms
03/26 09:48:39 Trace: [library] endmutation in 18ms
03/26 09:48:39 Trace: [library] endmutation in 19ms
03/26 09:48:39 Trace: [library] endmutation in 24ms
03/26 09:48:39 Trace: [library] endmutation in 16ms
03/26 09:48:39 Trace: [library] endmutation in 19ms
03/26 09:48:39 Trace: [library] endmutation in 19ms
03/26 09:48:40 Trace: [library] endmutation in 14ms
03/26 09:48:40 Trace: [library] endmutation in 18ms
03/26 09:48:40 Trace: [library] endmutation in 18ms
03/26 09:48:40 Trace: [library] endmutation in 25ms
03/26 09:48:40 Trace: [library] endmutation in 17ms
03/26 09:48:40 Trace: [library] endmutation in 17ms
03/26 09:48:40 Trace: [library] endmutation in 22ms
03/26 09:48:40 Trace: [library] endmutation in 16ms
03/26 09:48:40 Trace: [library] endmutation in 21ms
03/26 09:48:40 Trace: [library] endmutation in 17ms
03/26 09:48:40 Trace: [library] endmutation in 14ms
03/26 09:48:40 Trace: [library] endmutation in 18ms
03/26 09:48:40 Trace: [library] endmutation in 17ms
03/26 09:48:40 Trace: [library] endmutation in 21ms
03/26 09:48:40 Trace: [library] endmutation in 14ms
03/26 09:48:40 Trace: [library] endmutation in 13ms
03/26 09:48:40 Trace: [library] endmutation in 16ms
03/26 09:48:40 Trace: [library] endmutation in 13ms
03/26 09:48:40 Trace: [library] endmutation in 16ms
03/26 09:48:40 Trace: [library] endmutation in 16ms
03/26 09:48:40 Trace: [library] endmutation in 23ms
03/26 09:48:40 Trace: [library] endmutation in 16ms
03/26 09:48:40 Trace: [library] endmutation in 15ms
03/26 09:48:40 Trace: [library] endmutation in 18ms
03/26 09:48:41 Trace: [library] endmutation in 17ms
03/26 09:48:41 Trace: [library] endmutation in 17ms
03/26 09:48:41 Trace: [library] endmutation in 20ms
03/26 09:48:41 Trace: [library] endmutation in 20ms
03/26 09:48:41 Trace: [library] endmutation in 22ms
03/26 09:48:41 Trace: [library] endmutation in 17ms
03/26 09:48:41 Trace: [library] endmutation in 18ms
03/26 09:48:41 Trace: [library] endmutation in 19ms
03/26 09:48:41 Trace: [library] endmutation in 18ms
03/26 09:48:41 Trace: [library] endmutation in 20ms
03/26 09:48:41 Trace: [library] endmutation in 19ms
03/26 09:48:41 Trace: [library] endmutation in 16ms
03/26 09:48:41 Trace: [library] endmutation in 17ms
03/26 09:48:41 Trace: [library] endmutation in 19ms
03/26 09:48:42 Trace: [library] endmutation in 16ms
03/26 09:48:42 Trace: [library] endmutation in 16ms
03/26 09:48:42 Trace: [library] endmutation in 18ms
03/26 09:48:42 Trace: [library] endmutation in 13ms
03/26 09:48:42 Trace: [library] endmutation in 11ms
03/26 09:48:42 Trace: [library] endmutation in 16ms
03/26 09:48:42 Trace: [library] endmutation in 14ms
03/26 09:48:42 Trace: [library] endmutation in 15ms
03/26 09:48:42 Trace: [library] endmutation in 18ms
03/26 09:48:42 Trace: [library] endmutation in 17ms
03/26 09:48:42 Trace: [library] endmutation in 17ms
03/26 09:48:42 Trace: [library] endmutation in 18ms
03/26 09:48:43 Trace: [library] endmutation in 25ms
03/26 09:48:43 Trace: [library] endmutation in 20ms
03/26 09:48:43 Trace: [library] endmutation in 16ms
03/26 09:48:43 Trace: [library] endmutation in 18ms
03/26 09:48:43 Trace: [library] endmutation in 18ms
03/26 09:48:43 Trace: [library] endmutation in 25ms
03/26 09:48:43 Trace: [library] endmutation in 17ms
03/26 09:48:43 Trace: [library] endmutation in 17ms
03/26 09:48:43 Trace: [library] endmutation in 18ms
03/26 09:48:43 Trace: [library] endmutation in 19ms
03/26 09:48:43 Trace: [library] endmutation in 19ms
03/26 09:48:43 Trace: [library] endmutation in 27ms
03/26 09:48:44 Trace: [library] endmutation in 19ms
03/26 09:48:44 Trace: [library] endmutation in 20ms
03/26 09:48:44 Trace: [library] endmutation in 21ms
03/26 09:48:44 Trace: [library] endmutation in 16ms
03/26 09:48:44 Trace: [library] endmutation in 20ms
03/26 09:48:44 Trace: [library] endmutation in 19ms
03/26 09:48:44 Trace: [library] endmutation in 18ms
03/26 09:48:44 Trace: [library] endmutation in 20ms
03/26 09:48:44 Trace: [library] endmutation in 19ms
03/26 09:48:44 Trace: [library] endmutation in 20ms
03/26 09:48:44 Trace: [library] endmutation in 21ms
03/26 09:48:44 Trace: [library] endmutation in 31ms
03/26 09:48:44 Trace: [library] endmutation in 19ms
03/26 09:48:45 Trace: [library] endmutation in 18ms
03/26 09:48:45 Trace: [library] endmutation in 22ms
03/26 09:48:45 Trace: [library] endmutation in 17ms
03/26 09:48:45 Trace: [library] endmutation in 19ms
03/26 09:48:45 Trace: [library] endmutation in 20ms
03/26 09:48:45 Trace: [library] endmutation in 21ms
03/26 09:48:45 Trace: [library] endmutation in 26ms
03/26 09:48:45 Trace: [library] endmutation in 29ms
03/26 09:48:45 Trace: [library] endmutation in 22ms
03/26 09:48:45 Trace: [library] endmutation in 18ms
03/26 09:48:45 Trace: [library] endmutation in 27ms
03/26 09:48:45 Trace: [library] endmutation in 21ms
03/26 09:48:46 Trace: [library] endmutation in 24ms
03/26 09:48:46 Trace: [library] endmutation in 23ms
03/26 09:48:46 Trace: [library] endmutation in 26ms
03/26 09:48:46 Trace: [library] endmutation in 21ms
03/26 09:48:46 Trace: [library] endmutation in 21ms
03/26 09:48:47 Trace: [library] endmutation in 26ms
03/26 09:48:47 Trace: [library] endmutation in 19ms
03/26 09:48:47 Trace: [library] endmutation in 23ms
03/26 09:48:47 Trace: [library] endmutation in 20ms
03/26 09:48:47 Trace: [library] endmutation in 23ms
03/26 09:48:47 Trace: [library] endmutation in 33ms
03/26 09:48:47 Trace: [library] endmutation in 23ms
03/26 09:48:48 Trace: [library] endmutation in 21ms
03/26 09:48:48 Trace: [library] endmutation in 30ms
03/26 09:48:48 Trace: [library] endmutation in 21ms
03/26 09:48:48 Trace: [library] endmutation in 29ms
03/26 09:48:49 Trace: [library] endmutation in 26ms
03/26 09:48:49 Trace: [library] endmutation in 17ms
03/26 09:48:49 Trace: [library] endmutation in 21ms
03/26 09:48:49 Trace: [library] endmutation in 19ms
03/26 09:48:49 Trace: [library] endmutation in 26ms
03/26 09:48:49 Trace: [library] endmutation in 18ms
03/26 09:48:49 Trace: [library] endmutation in 24ms
03/26 09:48:49 Trace: [library] endmutation in 20ms
03/26 09:48:50 Trace: [library] endmutation in 23ms
03/26 09:48:50 Info: [stats] 415701mb Virtual, 6287mb Physical, 7113mb Managed
03/26 09:48:50 Trace: [library] endmutation in 18ms
03/26 09:48:50 Trace: [library] endmutation in 26ms
03/26 09:48:50 Trace: [library] endmutation in 20ms
03/26 09:48:51 Trace: [library] endmutation in 20ms
03/26 09:48:51 Trace: [library] endmutation in 30ms
03/26 09:48:51 Trace: [library] endmutation in 23ms
03/26 09:48:51 Trace: [library] endmutation in 23ms
03/26 09:48:51 Trace: [library] endmutation in 24ms
03/26 09:48:51 Trace: [library] endmutation in 29ms
03/26 09:48:52 Trace: [library] endmutation in 22ms
03/26 09:48:52 Trace: [library] endmutation in 19ms
03/26 09:48:52 Trace: [library] endmutation in 20ms
03/26 09:48:52 Trace: [library] endmutation in 29ms
03/26 09:48:52 Trace: [library] endmutation in 22ms
03/26 09:48:52 Trace: [library] endmutation in 21ms
03/26 09:48:53 Trace: [library] endmutation in 26ms
03/26 09:48:53 Trace: [library] endmutation in 28ms
03/26 09:48:53 Trace: [library] endmutation in 20ms
03/26 09:48:53 Trace: [library] endmutation in 19ms
03/26 09:48:53 Trace: [library] endmutation in 25ms
03/26 09:48:54 Trace: [library] endmutation in 26ms
03/26 09:48:54 Trace: [library] endmutation in 20ms
03/26 09:48:54 Trace: [library] endmutation in 29ms
03/26 09:48:54 Trace: [library] endmutation in 21ms
03/26 09:48:55 Trace: [library] endmutation in 17ms
03/26 09:48:55 Trace: [library] endmutation in 22ms
03/26 09:48:55 Trace: [library] endmutation in 24ms
03/26 09:48:55 Trace: [library] endmutation in 26ms
03/26 09:48:55 Trace: [library] endmutation in 26ms
03/26 09:48:55 Trace: [library] endmutation in 17ms
03/26 09:48:56 Trace: [library] endmutation in 25ms
03/26 09:48:56 Trace: [library] endmutation in 20ms
03/26 09:48:56 Trace: [library] endmutation in 17ms
03/26 09:48:56 Trace: [library] endmutation in 21ms
03/26 09:48:56 Trace: [library] endmutation in 29ms
03/26 09:48:56 Trace: [library] endmutation in 27ms
03/26 09:48:57 Trace: [library] endmutation in 21ms
03/26 09:48:57 Trace: [library] endmutation in 18ms
03/26 09:48:57 Trace: [library] endmutation in 22ms
03/26 09:48:57 Trace: [library] endmutation in 22ms
03/26 09:48:57 Trace: [library] endmutation in 32ms
03/26 09:48:57 Trace: [library] endmutation in 20ms
03/26 09:48:57 Trace: [library] endmutation in 19ms
03/26 09:48:57 Trace: [library] endmutation in 22ms
03/26 09:48:57 Trace: [library] endmutation in 18ms
03/26 09:48:57 Trace: [library] endmutation in 21ms
03/26 09:48:58 Trace: [library] endmutation in 17ms
03/26 09:48:58 Trace: [library] endmutation in 28ms
03/26 09:48:58 Trace: [library] endmutation in 18ms
03/26 09:48:58 Trace: [library] endmutation in 20ms
03/26 09:48:58 Trace: [library] endmutation in 19ms
03/26 09:48:58 Trace: [library] endmutation in 24ms
03/26 09:48:58 Trace: [library] endmutation in 21ms
03/26 09:48:58 Trace: [library] endmutation in 22ms
03/26 09:48:58 Trace: [library] endmutation in 33ms
03/26 09:48:59 Trace: [library] endmutation in 20ms
03/26 09:48:59 Trace: [library] endmutation in 21ms
03/26 09:48:59 Trace: [library] endmutation in 32ms
03/26 09:48:59 Trace: [library] endmutation in 21ms
03/26 09:48:59 Trace: [library] endmutation in 22ms
03/26 09:48:59 Trace: [library] endmutation in 22ms
03/26 09:48:59 Trace: [library] endmutation in 30ms
03/26 09:48:59 Trace: [library] endmutation in 17ms
03/26 09:48:59 Trace: [library] endmutation in 20ms
03/26 09:48:59 Trace: [library] endmutation in 19ms
03/26 09:48:59 Trace: [library] endmutation in 24ms
03/26 09:48:59 Trace: [library] endmutation in 22ms
03/26 09:48:59 Trace: [library] endmutation in 23ms
03/26 09:48:59 Trace: [library] endmutation in 23ms
03/26 09:48:59 Trace: [library] endmutation in 19ms
03/26 09:48:59 Trace: [library] endmutation in 24ms
03/26 09:49:00 Trace: [library] endmutation in 20ms
03/26 09:49:00 Trace: [library] endmutation in 17ms
03/26 09:49:00 Trace: [library] endmutation in 20ms
03/26 09:49:00 Trace: [library] endmutation in 20ms
03/26 09:49:00 Trace: [library] endmutation in 20ms
03/26 09:49:00 Trace: [library] endmutation in 17ms
03/26 09:49:00 Trace: [library] endmutation in 20ms
03/26 09:49:00 Trace: [library] endmutation in 19ms
03/26 09:49:00 Trace: [library] endmutation in 25ms
03/26 09:49:00 Trace: [library] endmutation in 21ms
03/26 09:49:00 Trace: [library] endmutation in 21ms
03/26 09:49:00 Trace: [library] endmutation in 22ms
03/26 09:49:01 Trace: [library] endmutation in 31ms
03/26 09:49:01 Trace: [library] endmutation in 20ms
03/26 09:49:01 Trace: [library] endmutation in 18ms
03/26 09:49:01 Trace: [library] endmutation in 21ms
03/26 09:49:01 Trace: [library] endmutation in 22ms
03/26 09:49:01 Trace: [library] endmutation in 30ms
03/26 09:49:01 Trace: [library] endmutation in 21ms
03/26 09:49:01 Trace: [library] endmutation in 20ms
03/26 09:49:01 Trace: [library] endmutation in 19ms
03/26 09:49:01 Trace: [library] endmutation in 22ms
03/26 09:49:02 Trace: [library] endmutation in 19ms
03/26 09:49:02 Trace: [library] endmutation in 19ms
03/26 09:49:02 Trace: [library] endmutation in 17ms
03/26 09:49:02 Trace: [library] endmutation in 18ms
03/26 09:49:02 Trace: [library] endmutation in 18ms
03/26 09:49:02 Trace: [library] endmutation in 19ms
03/26 09:49:02 Trace: [library] endmutation in 16ms
03/26 09:49:02 Trace: [library] endmutation in 21ms
03/26 09:49:02 Trace: [library] endmutation in 18ms
03/26 09:49:02 Trace: [library] endmutation in 17ms
03/26 09:49:02 Trace: [library] endmutation in 20ms
03/26 09:49:02 Trace: [library] endmutation in 17ms
03/26 09:49:02 Trace: [library] endmutation in 17ms
03/26 09:49:02 Trace: [library] endmutation in 16ms
03/26 09:49:03 Trace: [library] endmutation in 22ms
03/26 09:49:03 Trace: [library] endmutation in 17ms
03/26 09:49:03 Trace: [library] endmutation in 18ms
03/26 09:49:03 Trace: [library] endmutation in 18ms
03/26 09:49:03 Trace: [library] endmutation in 18ms
03/26 09:49:03 Trace: [library] endmutation in 19ms
03/26 09:49:03 Trace: [library] endmutation in 27ms
03/26 09:49:03 Trace: [library] endmutation in 19ms
03/26 09:49:03 Trace: [library] endmutation in 18ms
03/26 09:49:03 Trace: [library] endmutation in 23ms
03/26 09:49:03 Trace: [library] endmutation in 21ms
03/26 09:49:03 Trace: [library] endmutation in 22ms
03/26 09:49:04 Trace: [library] endmutation in 22ms
03/26 09:49:04 Trace: [library] endmutation in 21ms
03/26 09:49:04 Trace: [library] endmutation in 18ms
03/26 09:49:04 Trace: [library] endmutation in 19ms
03/26 09:49:04 Trace: [library] endmutation in 22ms
03/26 09:49:04 Trace: [library] endmutation in 20ms
03/26 09:49:04 Trace: [library] endmutation in 21ms
03/26 09:49:04 Trace: [library] endmutation in 22ms
03/26 09:49:04 Trace: [library] endmutation in 21ms
03/26 09:49:04 Trace: [library] endmutation in 28ms
03/26 09:49:04 Trace: [library] endmutation in 21ms
03/26 09:49:04 Trace: [library] endmutation in 22ms
03/26 09:49:04 Trace: [library] endmutation in 23ms
03/26 09:49:04 Trace: [library] endmutation in 32ms
03/26 09:49:05 Trace: [library] endmutation in 21ms
03/26 09:49:05 Trace: [library] endmutation in 20ms
03/26 09:49:05 Trace: [library] endmutation in 21ms
03/26 09:49:05 Info: [stats] 415701mb Virtual, 5910mb Physical, 5917mb Managed
03/26 09:49:05 Trace: [library] endmutation in 22ms
03/26 09:49:05 Trace: [library] endmutation in 23ms
03/26 09:49:05 Trace: [library] endmutation in 31ms
03/26 09:49:05 Trace: [library] endmutation in 21ms
03/26 09:49:05 Trace: [library] endmutation in 20ms
03/26 09:49:05 Trace: [library] endmutation in 18ms
03/26 09:49:05 Trace: [library] endmutation in 27ms
03/26 09:49:05 Trace: [library] endmutation in 20ms
03/26 09:49:05 Trace: [library] endmutation in 19ms
03/26 09:49:05 Trace: [library] endmutation in 22ms
03/26 09:49:05 Trace: [library] endmutation in 20ms
03/26 09:49:06 Trace: [library] endmutation in 18ms
03/26 09:49:06 Trace: [library] endmutation in 23ms
03/26 09:49:06 Trace: [library] endmutation in 20ms
03/26 09:49:06 Trace: [library] endmutation in 23ms
03/26 09:49:06 Trace: [library] endmutation in 21ms
03/26 09:49:06 Trace: [library] endmutation in 21ms
03/26 09:49:06 Trace: [library] endmutation in 23ms
03/26 09:49:06 Trace: [library] endmutation in 32ms
03/26 09:49:07 Trace: [library] endmutation in 21ms
03/26 09:49:07 Trace: [library] endmutation in 21ms
03/26 09:49:07 Trace: [library] endmutation in 24ms
03/26 09:49:07 Trace: [library] endmutation in 22ms
03/26 09:49:07 Trace: [library] endmutation in 31ms
03/26 09:49:07 Trace: [library] endmutation in 19ms
03/26 09:49:07 Trace: [library] endmutation in 22ms
03/26 09:49:07 Trace: [library] endmutation in 21ms
03/26 09:49:07 Trace: [library] endmutation in 25ms
03/26 09:49:07 Trace: [library] endmutation in 21ms
03/26 09:49:08 Trace: [library] endmutation in 18ms
03/26 09:49:08 Trace: [library] endmutation in 22ms
03/26 09:49:08 Trace: [library] endmutation in 22ms
03/26 09:49:08 Trace: [library] endmutation in 36ms
03/26 09:49:08 Trace: [library] endmutation in 21ms
03/26 09:49:08 Trace: [library] endmutation in 21ms
03/26 09:49:08 Trace: [library] endmutation in 27ms
03/26 09:49:08 Trace: [library] endmutation in 20ms
03/26 09:49:08 Trace: [library] endmutation in 22ms
03/26 09:49:08 Trace: [library] endmutation in 25ms
03/26 09:49:08 Trace: [library] endmutation in 19ms
03/26 09:49:08 Trace: [library] endmutation in 21ms
03/26 09:49:08 Trace: [library] endmutation in 22ms
03/26 09:49:08 Trace: [library] endmutation in 34ms
03/26 09:49:08 Trace: [library] endmutation in 21ms
03/26 09:49:08 Trace: [library] endmutation in 22ms
03/26 09:49:08 Trace: [library] endmutation in 21ms
03/26 09:49:08 Trace: [library] endmutation in 27ms
03/26 09:49:09 Trace: [library] endmutation in 21ms
03/26 09:49:09 Trace: [library] endmutation in 19ms
03/26 09:49:09 Trace: [library] endmutation in 21ms
03/26 09:49:09 Trace: [library] endmutation in 20ms
03/26 09:49:09 Trace: [library] endmutation in 23ms
03/26 09:49:09 Trace: [library] endmutation in 21ms
03/26 09:49:09 Trace: [library] endmutation in 22ms
03/26 09:49:09 Trace: [library] endmutation in 25ms
03/26 09:49:09 Trace: [library] endmutation in 18ms
03/26 09:49:09 Trace: [library] endmutation in 21ms
03/26 09:49:09 Trace: [library] endmutation in 20ms
03/26 09:49:09 Trace: [library] endmutation in 18ms
03/26 09:49:10 Trace: [library] endmutation in 19ms
03/26 09:49:10 Trace: [library] endmutation in 20ms
03/26 09:49:10 Trace: [library] endmutation in 22ms
03/26 09:49:10 Trace: [library] endmutation in 21ms
03/26 09:49:10 Trace: [library] endmutation in 22ms
03/26 09:49:10 Trace: [library] endmutation in 29ms
03/26 09:49:11 Trace: [library] endmutation in 21ms
03/26 09:49:11 Trace: [library] endmutation in 22ms
03/26 09:49:11 Trace: [library] endmutation in 29ms
03/26 09:49:11 Trace: [library] endmutation in 22ms
03/26 09:49:11 Trace: [library] endmutation in 22ms
03/26 09:49:11 Trace: [library] endmutation in 31ms
03/26 09:49:11 Trace: [library] endmutation in 21ms
03/26 09:49:11 Trace: [library] endmutation in 18ms
03/26 09:49:11 Trace: [library] endmutation in 21ms
03/26 09:49:11 Trace: [library] endmutation in 25ms
03/26 09:49:11 Trace: [library] endmutation in 21ms
03/26 09:49:12 Trace: [library] endmutation in 19ms
03/26 09:49:12 Trace: [library] endmutation in 24ms
03/26 09:49:12 Trace: [library] endmutation in 19ms
03/26 09:49:12 Trace: [library] endmutation in 23ms
03/26 09:49:12 Trace: [library] endmutation in 31ms
03/26 09:49:12 Trace: [library] endmutation in 19ms
03/26 09:49:12 Trace: [library] endmutation in 22ms
03/26 09:49:12 Trace: [library] endmutation in 22ms
03/26 09:49:13 Trace: [library] endmutation in 22ms
03/26 09:49:13 Trace: [library] endmutation in 23ms
03/26 09:49:13 Trace: [library] endmutation in 21ms
03/26 09:49:13 Trace: [library] endmutation in 21ms
03/26 09:49:13 Trace: [library] endmutation in 20ms
03/26 09:49:13 Trace: [library] endmutation in 23ms
03/26 09:49:13 Trace: [library] endmutation in 21ms
03/26 09:49:13 Trace: [library] endmutation in 27ms
03/26 09:49:13 Trace: [library] endmutation in 19ms
03/26 09:49:13 Trace: [library] endmutation in 21ms
03/26 09:49:13 Trace: [library] endmutation in 19ms
03/26 09:49:13 Trace: [library] endmutation in 21ms
03/26 09:49:13 Trace: [library] endmutation in 21ms
03/26 09:49:13 Trace: [library] endmutation in 23ms
03/26 09:49:13 Trace: [library] endmutation in 22ms
03/26 09:49:13 Trace: [library] endmutation in 21ms
03/26 09:49:14 Trace: [library] endmutation in 22ms
03/26 09:49:14 Trace: [library] endmutation in 22ms
03/26 09:49:14 Trace: [library] endmutation in 23ms
03/26 09:49:14 Trace: [library] endmutation in 20ms
03/26 09:49:14 Trace: [library] endmutation in 23ms
03/26 09:49:14 Trace: [library] endmutation in 22ms
03/26 09:49:14 Trace: [library] endmutation in 22ms
03/26 09:49:14 Trace: [library] endmutation in 22ms
03/26 09:49:14 Trace: [library] endmutation in 27ms
03/26 09:49:14 Trace: [library] endmutation in 21ms
03/26 09:49:14 Trace: [library] endmutation in 22ms
03/26 09:49:14 Trace: [library] endmutation in 23ms
03/26 09:49:15 Trace: [library] endmutation in 32ms
03/26 09:49:15 Trace: [library] endmutation in 21ms
03/26 09:49:15 Trace: [library] endmutation in 19ms
03/26 09:49:15 Trace: [library] endmutation in 22ms
03/26 09:49:15 Trace: [library] endmutation in 23ms
03/26 09:49:15 Trace: [library] endmutation in 32ms
03/26 09:49:15 Trace: [library] endmutation in 21ms
03/26 09:49:15 Trace: [library] endmutation in 19ms
03/26 09:49:15 Trace: [library] endmutation in 20ms
03/26 09:49:15 Trace: [library] endmutation in 21ms
03/26 09:49:15 Trace: [library] endmutation in 28ms
03/26 09:49:15 Trace: [library] endmutation in 21ms
03/26 09:49:16 Trace: [library] endmutation in 19ms
03/26 09:49:16 Trace: [library] endmutation in 21ms
03/26 09:49:16 Trace: [library] endmutation in 22ms
03/26 09:49:16 Trace: [library] endmutation in 21ms
03/26 09:49:16 Trace: [library] endmutation in 20ms
03/26 09:49:16 Trace: [library] endmutation in 23ms
03/26 09:49:16 Trace: [library] endmutation in 21ms
03/26 09:49:17 Trace: [library] endmutation in 26ms
03/26 09:49:17 Trace: [library] endmutation in 21ms
03/26 09:49:17 Trace: [library] endmutation in 21ms
03/26 09:49:17 Trace: [library] endmutation in 22ms
03/26 09:49:17 Trace: [library] endmutation in 22ms
03/26 09:49:17 Trace: [library] endmutation in 19ms
03/26 09:49:17 Trace: [library] endmutation in 22ms
03/26 09:49:17 Trace: [library] endmutation in 22ms
03/26 09:49:17 Trace: [library] endmutation in 21ms
03/26 09:49:17 Trace: [library] endmutation in 21ms
03/26 09:49:17 Trace: [library] endmutation in 22ms
03/26 09:49:17 Trace: [library] endmutation in 26ms
03/26 09:49:18 Trace: [library] endmutation in 23ms
03/26 09:49:18 Trace: [library] endmutation in 22ms
03/26 09:49:18 Trace: [library] endmutation in 23ms
03/26 09:49:18 Trace: [library] endmutation in 22ms
03/26 09:49:18 Trace: [library] endmutation in 21ms
03/26 09:49:18 Trace: [library] endmutation in 22ms
03/26 09:49:18 Trace: [library] endmutation in 22ms
03/26 09:49:18 Trace: [library] endmutation in 21ms
03/26 09:49:18 Trace: [library] endmutation in 20ms
03/26 09:49:18 Trace: [library] endmutation in 24ms
03/26 09:49:18 Trace: [library] endmutation in 22ms
03/26 09:49:18 Trace: [library] endmutation in 22ms
03/26 09:49:18 Trace: [library] endmutation in 23ms
03/26 09:49:18 Trace: [library] endmutation in 32ms
03/26 09:49:19 Trace: [library] endmutation in 21ms
03/26 09:49:19 Trace: [library] endmutation in 19ms
03/26 09:49:19 Trace: [library] endmutation in 22ms
03/26 09:49:19 Trace: [library] endmutation in 23ms
03/26 09:49:19 Trace: [library] endmutation in 31ms
03/26 09:49:19 Trace: [library] endmutation in 21ms
03/26 09:49:19 Trace: [library] endmutation in 20ms
03/26 09:49:19 Trace: [library] endmutation in 23ms
03/26 09:49:19 Trace: [library] endmutation in 20ms
03/26 09:49:19 Trace: [library] endmutation in 22ms
03/26 09:49:19 Trace: [library] endmutation in 22ms
03/26 09:49:20 Trace: [library] endmutation in 25ms
03/26 09:49:20 Info: [stats] 415700mb Virtual, 5851mb Physical, 6419mb Managed
03/26 09:49:20 Trace: [library] endmutation in 19ms
03/26 09:49:20 Trace: [library] endmutation in 22ms
03/26 09:49:20 Trace: [library] endmutation in 19ms
03/26 09:49:20 Trace: [library] endmutation in 22ms
03/26 09:49:20 Trace: [library] endmutation in 23ms
03/26 09:49:20 Trace: [library] endmutation in 31ms
03/26 09:49:20 Trace: [library] endmutation in 22ms
03/26 09:49:21 Trace: [library] endmutation in 23ms
03/26 09:49:21 Trace: [library] endmutation in 19ms
03/26 09:49:21 Trace: [library] endmutation in 21ms
03/26 09:49:21 Trace: [library] endmutation in 21ms
03/26 09:49:21 Trace: [library] endmutation in 23ms
03/26 09:49:21 Trace: [library] endmutation in 22ms
03/26 09:49:21 Trace: [library] endmutation in 22ms
03/26 09:49:21 Trace: [library] endmutation in 21ms
03/26 09:49:21 Trace: [library] endmutation in 24ms
03/26 09:49:21 Trace: [library] endmutation in 22ms
03/26 09:49:21 Trace: [library] endmutation in 22ms
03/26 09:49:22 Trace: [library] endmutation in 22ms
03/26 09:49:22 Trace: [library] endmutation in 19ms
03/26 09:49:22 Trace: [library] endmutation in 19ms
03/26 09:49:22 Trace: [library] endmutation in 24ms
03/26 09:49:22 Trace: [library] endmutation in 22ms
03/26 09:49:22 Trace: [library] endmutation in 22ms
03/26 09:49:22 Trace: [library] endmutation in 22ms
03/26 09:49:22 Trace: [broker/accounts] [heartbeat] now=3/26/2024 1:49:22PM nextauthrefresh=3/26/2024 2:39:23PM nextmachineallocate=3/26/2024 5:39:22PM
03/26 09:49:22 Trace: [library] endmutation in 19ms
03/26 09:49:23 Trace: [library] endmutation in 19ms
03/26 09:49:23 Trace: [library] endmutation in 23ms
03/26 09:49:23 Trace: [library] endmutation in 19ms
03/26 09:49:23 Trace: [library] endmutation in 19ms
03/26 09:49:23 Trace: [library] endmutation in 23ms
03/26 09:49:23 Trace: [library] endmutation in 21ms
03/26 09:49:23 Trace: [library] endmutation in 24ms
03/26 09:49:23 Trace: [library] endmutation in 20ms
03/26 09:49:24 Trace: [library] endmutation in 19ms
03/26 09:49:24 Trace: [library] endmutation in 20ms
03/26 09:49:24 Trace: [library] endmutation in 25ms
03/26 09:49:24 Trace: [library] endmutation in 24ms
03/26 09:49:24 Trace: [library] endmutation in 21ms
03/26 09:49:24 Trace: [library] endmutation in 25ms
03/26 09:49:24 Trace: [library] endmutation in 21ms
03/26 09:49:24 Trace: [library] endmutation in 20ms
03/26 09:49:24 Trace: [library] endmutation in 23ms
03/26 09:49:25 Trace: [library] endmutation in 19ms
03/26 09:49:25 Trace: [library] endmutation in 22ms
03/26 09:49:25 Trace: [library] endmutation in 21ms
03/26 09:49:25 Trace: [library] endmutation in 29ms
03/26 09:49:25 Trace: [library] endmutation in 21ms
03/26 09:49:25 Trace: [library] endmutation in 25ms
03/26 09:49:25 Trace: [library] endmutation in 19ms
03/26 09:49:25 Trace: [library] endmutation in 19ms
03/26 09:49:25 Trace: [library] endmutation in 19ms
03/26 09:49:25 Trace: [library] endmutation in 24ms
03/26 09:49:26 Trace: [library] endmutation in 19ms
03/26 09:49:26 Trace: [library] endmutation in 24ms
03/26 09:49:26 Trace: [library] endmutation in 21ms
03/26 09:49:26 Trace: [library] endmutation in 24ms
03/26 09:49:26 Trace: [library] endmutation in 22ms
03/26 09:49:26 Trace: [library] endmutation in 23ms
03/26 09:49:26 Trace: [library] endmutation in 30ms
03/26 09:49:26 Trace: [library] endmutation in 21ms
03/26 09:49:26 Trace: [library] endmutation in 22ms
03/26 09:49:26 Trace: [library] endmutation in 23ms
03/26 09:49:26 Trace: [library] endmutation in 21ms
03/26 09:49:27 Trace: [library] endmutation in 19ms
03/26 09:49:27 Trace: [library] endmutation in 22ms
03/26 09:49:27 Trace: [library] endmutation in 19ms
03/26 09:49:28 Trace: [library] endmutation in 21ms
03/26 09:49:28 Trace: [library] endmutation in 24ms
03/26 09:49:28 Trace: [library] endmutation in 19ms
03/26 09:49:28 Trace: [library] endmutation in 21ms
03/26 09:49:28 Trace: [library] endmutation in 23ms
03/26 09:49:28 Trace: [library] endmutation in 23ms
03/26 09:49:29 Trace: [library] endmutation in 31ms
03/26 09:49:29 Trace: [library] endmutation in 24ms
03/26 09:49:29 Trace: [library] endmutation in 22ms
03/26 09:49:29 Trace: [library] endmutation in 27ms
03/26 09:49:29 Trace: [library] endmutation in 19ms
03/26 09:49:29 Trace: [library] endmutation in 22ms
03/26 09:49:29 Trace: [library] endmutation in 21ms
03/26 09:49:29 Trace: [library] endmutation in 24ms
03/26 09:49:30 Trace: [library] endmutation in 27ms
03/26 09:49:30 Trace: [library] endmutation in 30ms
03/26 09:49:30 Trace: [library] endmutation in 22ms
03/26 09:49:30 Trace: [library] endmutation in 23ms
03/26 09:49:30 Trace: [library] endmutation in 23ms
03/26 09:49:30 Trace: [library] endmutation in 28ms
03/26 09:49:30 Trace: [library] endmutation in 19ms
03/26 09:49:30 Trace: [library] endmutation in 22ms
03/26 09:49:30 Trace: [library] endmutation in 23ms
03/26 09:49:31 Trace: [library] endmutation in 22ms
03/26 09:49:31 Trace: [library] endmutation in 23ms
03/26 09:49:31 Trace: [library] endmutation in 31ms
03/26 09:49:31 Trace: [library] endmutation in 20ms
03/26 09:49:31 Trace: [library] endmutation in 22ms
03/26 09:49:31 Trace: [library] endmutation in 22ms
03/26 09:49:31 Trace: [library] endmutation in 22ms
03/26 09:49:31 Trace: [library] endmutation in 26ms
03/26 09:49:31 Trace: [library] endmutation in 23ms
03/26 09:49:31 Trace: [library] endmutation in 20ms
03/26 09:49:32 Trace: [library] endmutation in 23ms
03/26 09:49:32 Trace: [library] endmutation in 14ms
03/26 09:49:32 Trace: [library] endmutation in 16ms
03/26 09:49:32 Trace: [library] endmutation in 11ms
03/26 09:49:32 Trace: [library] endmutation in 11ms
03/26 09:49:32 Trace: [library] endmutation in 11ms
03/26 09:49:32 Trace: [library] endmutation in 15ms
03/26 09:49:32 Trace: [zone System Output] Loaded Queue=798 Tracks Swim=Inactive AutoSwim=True Loop=Disabled Shuffle=False
03/26 09:49:32 Trace: [System Output] [Inactive] [PAUSED @ 0:10/4:41] Catching the Sun - Spyro Gyra / Randy Brecker / Chet Catallo / Jay Beckenstein
03/26 09:49:32 Trace: [zone VAULT 2i - 69B7] Loaded Queue=8000 Tracks Swim=Inactive AutoSwim=False Loop=Disabled Shuffle=False
03/26 09:49:33 Trace: [VAULT 2i - 69B7] [Lossless, 16/44 FLAC => 16/44] [100% buf] [PAUSED @ 2:46/4:51] Eternal Child - Chick Corea Elektric Band / Chick Corea
03/26 09:49:33 Trace: GetImageData[Remote](id=7148 spec=500 key=yokaaaaa) => got from cache overalltime=0ms
03/26 09:49:33 Trace: GetImageData[Remote](id=7148 spec=500 key=yokaaaaa) => got from cache overalltime=7ms
03/26 09:49:33 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] SENT [8]{"request":"update_artwork","mimetype":"image/jpeg"}
03/26 09:49:33 Trace: [Bluesound VAULT 2i @ 10.0.1.6:43311] [raatclient] GOT [8] {"status":"Success"}
03/26 09:49:33 Trace: [zone Bluesound PULSE 2i + Exercise Room NODE - B8CA] Loaded Queue=8000 Tracks Swim=Inactive AutoSwim=False Loop=Disabled Shuffle=False
03/26 09:49:33 Trace: [PULSE 2i - 9727] [Enhanced, 16/44 QOBUZ FLAC => 24/44] [100% buf] [PAUSED @ 0:42/4:21] Philly - Spyro Gyra / Jim Kurzdorfer / Kim Kurzdorfer
03/26 09:49:33 Trace: GetImageData[Remote](id=466722 spec=500 key=wkoabaaa) => got from cache overalltime=0ms
03/26 09:49:33 Trace: GetImageData[Remote](id=466722 spec=500 key=wkoabaaa) => got from cache overalltime=1ms
03/26 09:49:33 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] SENT [8]{"request":"update_artwork","mimetype":"image/jpeg"}
03/26 09:49:33 Trace: [Exercise Room NODE - B8CA] [Lossless, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PAUSED @ 0:42/4:21] Philly - Spyro Gyra / Jim Kurzdorfer / Kim Kurzdorfer
03/26 09:49:33 Trace: GetImageData[Remote](id=466722 spec=500 key=wkoabaaa) => got from cache overalltime=0ms
03/26 09:49:33 Trace: GetImageData[Remote](id=466722 spec=500 key=wkoabaaa) => got from cache overalltime=0ms
03/26 09:49:33 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] SENT [8]{"request":"update_artwork","mimetype":"image/jpeg"}
03/26 09:49:33 Trace: [zone Master Bath Node] Loaded Queue=8000 Tracks Swim=Inactive AutoSwim=False Loop=Disabled Shuffle=False
03/26 09:49:33 Trace: [Bluesound PULSE 2i @ 10.0.1.190:36157] [raatclient] GOT [8] {"status":"Success"}
03/26 09:49:33 Trace: [Bluesound N130 @ 10.0.1.174:45113] [raatclient] GOT [8] {"status":"Success"}
03/26 09:49:33 Trace: [Master Bath Node] [Lossless, 16/44 FLAC => 16/44] [100% buf] [PAUSED @ 0:44/2:42] Over There, It's Raining - Nils Frahm
03/26 09:49:33 Trace: GetImageData[Remote](id=6031 spec=500 key=zxiaaaaa) => got from cache overalltime=0ms
03/26 09:49:33 Trace: GetImageData[Remote](id=6031 spec=500 key=zxiaaaaa) => got from cache overalltime=2ms
03/26 09:49:33 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] SENT [8]{"request":"update_artwork","mimetype":"image/jpeg"}
03/26 09:49:33 Trace: [zone Kitchen] Loaded Queue=8000 Tracks Swim=Inactive AutoSwim=False Loop=Disabled Shuffle=False
03/26 09:49:33 Trace: [Bluesound N130 @ 10.0.1.159:37841] [raatclient] GOT [8] {"status":"Success"}
03/26 09:49:33 Trace: [Kitchen] [Enhanced, 16/44 ALAC => 32/44] [100% buf] [PAUSED @ 1:37/3:33] Hot in the City - Billy Idol
03/26 09:49:33 Trace: GetImageData[Remote](id=2 spec=500 key=caaaaaaa) => got from cache overalltime=0ms
03/26 09:49:33 Trace: GetImageData[Remote](id=2 spec=500 key=caaaaaaa) => got from cache overalltime=2ms
03/26 09:49:33 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] SENT [8]{"request":"update_artwork","mimetype":"image/jpeg"}
03/26 09:49:33 Trace: [zone Library Evo 150] Loaded Queue=1606 Tracks Swim=Inactive AutoSwim=True Loop=Disabled Shuffle=False
03/26 09:49:33 Trace: [Library Evo 150] [Enhanced, 16/44 QOBUZ FLAC => 16/44] [100% buf] [PAUSED @ 0:30/6:57] With These Hands (Album Version) - Yellowjackets / Russell Ferrante / William Kennedy
03/26 09:49:33 Trace: GetImageData[Remote](id=153363 spec=500 key=pwsiaaaa) => got from cache overalltime=0ms
03/26 09:49:33 Trace: GetImageData[Remote](id=153363 spec=500 key=pwsiaaaa) => got from cache overalltime=10ms
03/26 09:49:33 Trace: [Rose RS520 @ 10.0.1.3:45865] [raatclient] GOT [8] {"status":"Success"}
03/26 09:49:33 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] SENT [8]{"request":"update_artwork","mimetype":"image/jpeg"}
03/26 09:49:33 Trace: [Cambridge Audio Evo 150 @ 10.0.1.2:45515] [raatclient] GOT [8] {"status":"Success"}
03/26 09:49:33 Trace: [zone Jason’s POWERNODE - 5B32] Loaded Queue=8000 Tracks Swim=Inactive AutoSwim=False Loop=Disabled Shuffle=False
03/26 09:49:33 Info: [broker/locations] updating location Qobuz:Name=QOBUZ:Id=f4845d8f-2574-4afe-9fbf-0a3ba8f37867
03/26 09:49:33 Trace: [Jason’s POWERNODE - 5B32] [Enhanced, 16/44 FLAC => 24/44] [100% buf] [PAUSED @ 6:02/7:04] The Fog - David Arkenstone
03/26 09:49:33 Trace: GetImageData[Remote](id=652006 spec=500 key=enclbaaa) => got from cache overalltime=0ms
03/26 09:49:33 Trace: GetImageData[Remote](id=652006 spec=500 key=enclbaaa) => got from cache overalltime=0ms
03/26 09:49:33 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] SENT [8]{"request":"update_artwork","mimetype":"image/jpeg"}
03/26 09:49:33 Trace: [Bluesound N330 @ 10.0.1.185:41945] [raatclient] GOT [8] {"status":"Success"}
03/26 09:49:34 Debug: [easyhttp] [24655] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=191:0:1214694&type=biography&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-us&tidal=max returned after 674 ms, status code: 200, request body size: 0 B
03/26 09:49:35 Info: [stats] 415699mb Virtual, 5776mb Physical, 6892mb Managed
03/26 09:49:44 Debug: [easyhttp] [24656] POST to https://api.roonlabs.net/device-map/1/register returned after 203 ms, status code: 200, request body size: 9 KB
03/26 09:49:44 Trace: [devicemap] device map updated
03/26 09:49:50 Info: [stats] 415700mb Virtual, 5412mb Physical, 6891mb Managed
03/26 09:50:05 Info: [stats] 415700mb Virtual, 5412mb Physical, 6892mb Managed
03/26 09:50:20 Info: [stats] 415700mb Virtual, 5377mb Physical, 6893mb Managed
03/26 09:50:35 Info: [stats] 415700mb Virtual, 5241mb Physical, 6896mb Managed
03/26 09:50:50 Info: [stats] 415701mb Virtual, 6099mb Physical, 5535mb Managed
03/26 09:51:05 Info: [stats] 415701mb Virtual, 5826mb Physical, 5536mb Managed
03/26 09:51:20 Info: [stats] 415699mb Virtual, 5667mb Physical, 5536mb Managed
03/26 09:51:35 Info: [stats] 415701mb Virtual, 5564mb Physical, 5537mb Managed
03/26 09:51:50 Info: [stats] 415700mb Virtual, 5568mb Physical, 5536mb Managed
03/26 09:52:05 Info: [stats] 415700mb Virtual, 5356mb Physical, 5537mb Managed
03/26 09:52:20 Info: [stats] 415700mb Virtual, 5358mb Physical, 5537mb Managed
03/26 09:52:35 Info: [stats] 415701mb Virtual, 5359mb Physical, 5536mb Managed
03/26 09:52:50 Info: [stats] 415700mb Virtual, 5313mb Physical, 5537mb Managed
03/26 09:52:53 Trace: [musicpowerstate] music has not been playing for 5 minutes, allowing idle sleep
03/26 09:53:05 Info: [stats] 415700mb Virtual, 5313mb Physical, 5536mb Managed
03/26 09:53:20 Info: [stats] 415701mb Virtual, 6168mb Physical, 5538mb Managed
03/26 09:53:35 Info: [stats] 415702mb Virtual, 6078mb Physical, 5540mb Managed
03/26 09:53:50 Info: [stats] 415700mb Virtual, 5791mb Physical, 5540mb Managed
03/26 09:54:05 Info: [stats] 415700mb Virtual, 5748mb Physical, 5541mb Managed
03/26 09:54:20 Info: [stats] 415700mb Virtual, 5695mb Physical, 5541mb Managed
03/26 09:54:22 Trace: [broker/accounts] [heartbeat] now=3/26/2024 1:54:22PM nextauthrefresh=3/26/2024 2:39:23PM nextmachineallocate=3/26/2024 5:39:22PM
03/26 09:54:35 Info: [stats] 415700mb Virtual, 5588mb Physical, 5541mb Managed
03/26 09:54:50 Info: [stats] 415700mb Virtual, 5590mb Physical, 5541mb Managed
03/26 09:55:05 Info: [stats] 415700mb Virtual, 5541mb Physical, 5540mb Managed
03/26 09:55:20 Info: [stats] 415700mb Virtual, 5542mb Physical, 5540mb Managed