Slow Track Changing local files Build 1234

Roon Core Machine

ROCK 7i7 16gb RAM

Networking Gear & Setup Details

Unifi router and aps and switches

Connected Audio Devices

Any

Number of Tracks in Library

61453

Description of Issue

Windows remote very buggy since this update, getting lots of graphical glitches.

More importantly changing albums or tracks from any remote whilst it’s currently playing is no longer instantaneous and can take a good few seconds to engage in some cases it’s 5-10. It’s not all the time either which is annoying. It also occurs skipping tracks.

I use DSP it sure if this is a factor and I have noticed its been slow last few builds. Same thing happens when switching DSP presets as well
which takes way more time than it used to. Is there some memory leak happening here ?

Took Roon 11 secs to start playng an album just now swapping from a local album to Qobuz one. Am I the only one experincing this? Getting it on all remotes. Network has not changed only the Roon build

03/19 00:25:16 Trace: [Lounge] [Enhanced, 16/44 QOBUZ FLAC => 32/44] [14% buf] [LOADING @ 0:00] Roadrunner - The Modern Lovers / Jonathan Richman & The Modern Lovers
03/19 00:25:16 Trace: [roonapi] [apiclient 192.168.5.227:43560] CONTINUE Changed {"zones_changed":[{"zone_id":"16018ff03739b586694b96eacb45c8a7939b","display_name":"Lounge","outputs":[{"output_id":"17018ff03739b586694b96eacb45c8a7939b","zone_id":"16018ff03739b586694b96eacb45c8a7939b","can_group_with_output_ids":["1701ce3d361363a043e28fa9ed5974675222","170195a9d03729bac7c5e441ca8183a560df","17018ff03739b586694b96eacb45c8a7939b","1701e4ed5ea97ad7acd7062abf21ed9e1ae5"],"display_name":"Lounge","volume":{"type":"number","min":0,"max":100,"value":33,"step":1,"is_muted":false,"hard_limit_min":0,"hard_limit_max":50,"soft_limit":40},"source_controls":[{"control_key":"1","display_name":"Naim Audio Uniti Atom","supports_standby":true,"status":"selected"}]}],"state":"stopped","is_next_allowed":true,"is_previous_allowed":true,"is_pause_allowed":false,"is_play_allowed":true,"is_seek_allowed":false,"queue_items_remaining":17,"queue_time_remaining":3739,"settings":{"loop":"disabled","shuffle":false,"auto_radio":false},"now_playing":{"seek_position":null,"length":246,"one_line":{"line1":"Roadrunner - The Modern Lovers / Jonathan Richman & The Modern Lovers"},"two_line":{"line1":"Roadrunner","line2":"The Modern Lovers / Jonathan Richman & The Modern Lovers"},"three_line":{"line1":"Roadrunner","line2":"The Modern Lovers / Jonathan Richman & The Modern Lovers","line3":"The Modern Lovers (Expanded Version)"},"image_key":"c3556660d3aa5f99086575addd7e5d6a","artist_image_keys":["3ab6f0986d3231fb10b80d963af40785","31248a0d1d4821a94d5479dff9d44458","f8c123ca06cf6160c2515b80e3d8d491"]}}],"zones_seek_changed":[{"zone_id":"16018ff03739b586694b96eacb45c8a7939b","queue_time_remaining":3739,"seek_position":null}]}
03/19 00:25:16 Trace: [dbperf] flush 0 bytes, 0 ops in 1 ms (cumulative 40515164 bytes, 36637 ops in 184204 ms)
03/19 00:25:16 Info: [library/albumdetails] found 1 ingroup alternates, 0 other alternates
03/19 00:25:16 Info: [library/albumdetails] Created album details screen for LibraryAlbum[4630575, The Modern Lovers, Jonathan Richman - The Modern Lovers (Expanded Version)]
03/19 00:25:16 Info: [library/albumdetails] 79004d5730303030363534333638, 79004d5230303031323937393634, 79004d5230303030373238313231, 79004d5230303034343330333532, 79004d5230303034353532373631, 79004d5230303033333233363333, 79004d5230303034363035383130, 79004d5230303031353233393134, 79004d5230303031353232363232, 79004d5230303031343238323439, 79004d5230303030323331333539, 79004d5230303035323837353630, 79004d5230303035303532313938, 79004d5230303030353332343535, 3e012d1ff2cac53b13439126902a2ae45851, 79004d5230303034393231353634, 3e01cb976d4d278cbf448281bf8329445c32, 3e01bee70e85e52ba737954e6a50cb1d9ce4, 3e01f6fe8d8edf6ae33489a937e920f1c9e6, 3e01c11db8655a7c084eb2aedb4bf77acf53, 3e0157d97140c31a353f9437c06d364ea8a3, 3e010be38028513ac034b1e82105b2a344a4, 3e010b65620a360b99308c57495409c80b48, 3e018c6f2a43d4f2a3428fffaf6032895de9, 3e01b41ea65358b34248b57e06c233c2bbd6, 3e017b42ab06b4062a4890c34981c294eadd, 3e019a3e5733c54e8d429f734f25839576ab, 3e0135af4347f5a17a4b9b22e3818f07988f, 79004d5230303031333031363030, 3e01f05c124ead301644ac615e913c130623, a6003633383839303535, c80035343134393339343831343735, cd00536f727038653039464f6348633852663550
03/19 00:25:16 Trace: [library] finished with 1 dirty performers 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 1 changed objects
03/19 00:25:16 Debug: [easyhttp] [8613] GET to https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&intent=stream&request_sig=8e6d16f4cab4f082c59f6aea96ad584c&request_ts=1679185516&track_id=11007252 returned after 142 ms, status code: 200, request body size: 0 B
03/19 00:25:16 Debug: [easyhttp] [8612] GET to https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&intent=stream&request_sig=859d19c240ba2b9e4bc7ab06caea13f3&request_ts=1679185516&track_id=11007251 returned after 163 ms, status code: 200, request body size: 0 B
03/19 00:25:16 Trace: GetImageData[Remote](id=20183 spec=500 key=hwdbaaaa uri=https://imagecache.roonlabs.net/im/1/albums/c80035343134393339343831343735/cover/500.jpg) => fetched in 197ms status=200 size=71214 overalltime=207ms
03/19 00:25:16 Trace: [Naim Audio Uniti Atom @ 192.168.5.8:50759] [raatclient] SENT [24203]{"request":"update_artwork","mimetype":"image/jpeg"}
03/19 00:25:16 Debug: [easyhttp] [8610] POST to https://www.qobuz.com/api.json/0.2/track/reportStreamingEnd? returned after 246 ms, status code: 200, request body size: 361 B
03/19 00:25:16 Trace: [Naim Audio Uniti Atom @ 192.168.5.8:50759] [raatclient] GOT [24203] {"status":"Success"}
03/19 00:25:16 Debug: [easyhttp] [8615] GET to https://www.qobuz.com/api.json/0.2/album/get?album_id=5414939481475&limit=0&offset=0&request_sig=457b70e169b9ea3e5ec023830cfb53bd&request_ts=1679185516 returned after 112 ms, status code: 200, request body size: 0 B
03/19 00:25:16 Debug: [easyhttp] [8614] POST to https://api.roonlabs.net/metadata/1/albums/translate?c=qobuz-gb returned after 168 ms, status code: 200, request body size: 1 KB
03/19 00:25:16 Debug: [music/profilestats] Computed stats in 191ms, got 50 top albums, 50 top performers, 38 genres
03/19 00:25:17 Trace: GetImageData[Remote](id=20183 spec=512 key=hwdbaaaa) => got from cache overalltime=0ms
03/19 00:25:17 Trace: GetImageData[Remote](id=20183 spec=512 key=hwdbaaaa) => got from cache overalltime=0ms
03/19 00:25:17 Info: sleep 477ms after flush
03/19 00:25:17 Trace: [roonapi] [apiclient 192.168.5.227:43560] CONTINUE Changed {"zones_changed":[{"zone_id":"16018ff03739b586694b96eacb45c8a7939b","display_name":"Lounge","outputs":[{"output_id":"17018ff03739b586694b96eacb45c8a7939b","zone_id":"16018ff03739b586694b96eacb45c8a7939b","can_group_with_output_ids":["1701ce3d361363a043e28fa9ed5974675222","170195a9d03729bac7c5e441ca8183a560df","17018ff03739b586694b96eacb45c8a7939b","1701e4ed5ea97ad7acd7062abf21ed9e1ae5"],"display_name":"Lounge","volume":{"type":"number","min":0,"max":100,"value":33,"step":1,"is_muted":false,"hard_limit_min":0,"hard_limit_max":50,"soft_limit":40},"source_controls":[{"control_key":"1","display_name":"Naim Audio Uniti Atom","supports_standby":true,"status":"selected"}]}],"state":"loading","is_next_allowed":true,"is_previous_allowed":true,"is_pause_allowed":true,"is_play_allowed":false,"is_seek_allowed":false,"queue_items_remaining":17,"queue_time_remaining":3739,"settings":{"loop":"disabled","shuffle":false,"auto_radio":false},"now_playing":{"seek_position":null,"length":246,"one_line":{"line1":"Roadrunner - The Modern Lovers / Jonathan Richman & The Modern Lovers"},"two_line":{"line1":"Roadrunner","line2":"The Modern Lovers / Jonathan Richman & The Modern Lovers"},"three_line":{"line1":"Roadrunner","line2":"The Modern Lovers / Jonathan Richman & The Modern Lovers","line3":"The Modern Lovers (Expanded Version)"},"image_key":"c3556660d3aa5f99086575addd7e5d6a","artist_image_keys":["3ab6f0986d3231fb10b80d963af40785","31248a0d1d4821a94d5479dff9d44458","f8c123ca06cf6160c2515b80e3d8d491"]}}]}
03/19 00:25:17 Trace: GetImageData[Remote](id=20183 spec=128 key=hwdbaaaa uri=https://imagecache.roonlabs.net/im/1/albums/c80035343134393339343831343735/cover/128.jpg) => fetched in 171ms status=200 size=7374 overalltime=172ms
03/19 00:25:17 Info: [stats] 26609mb Virtual, 4226mb Physical, 1958mb Managed, 532 Handles, 107 Threads
03/19 00:25:18 Debug: [music/profilestats] Computed stats in 1359ms, got 50 top albums, 50 top performers, 100 genres
03/19 00:25:18 Debug: [music/profilestats] Computed stats in 360ms, got 50 top albums, 50 top performers, 38 genres
03/19 00:25:19 Debug: [easyhttp] [8593] GET to https://api.roonlabs.net/discover/1/albums/121:0:MW0000654368/albums/morefromgenre?profileId=7fe3c25a-5754-428c-9ce8-1de03e5b7a1d&c=qobuz-gb&contentPreferences=avoidMqa returned after 5783 ms, status code: 200, request body size: 0 B
03/19 00:25:20 Debug: [music/profilestats] Computed stats in 1900ms, got 50 top albums, 50 top performers, 100 genres
03/19 00:25:21 Trace: GetImageData[Remote](id=20183 spec=1024 key=hwdbaaaa uri=https://imagecache.roonlabs.net/im/1/albums/c80035343134393339343831343735/cover/1024.jpg) => fetched in 1049ms status=200 size=353096 overalltime=1096ms
03/19 00:25:22 Debug: [music/profilestats] Computed stats in 1864ms, got 50 top albums, 50 top performers, 100 genres
03/19 00:25:24 Debug: [music/profilestats] Computed stats in 1856ms, got 50 top albums, 50 top performers, 100 genres
03/19 00:25:26 Debug: [music/profilestats] Computed stats in 1812ms, got 50 top albums, 50 top performers, 100 genres
03/19 00:25:26 Trace: [raatserver] [RaatServer prodmac17 @ 192.168.1.238:9200] client connection failed. Retrying in 1687ms
03/19 00:25:27 Trace: [raatserver] [RaatServer prodmac17 @ 192.168.1.238:9200] connecting (attempt 5)
03/19 00:25:28 Debug: [music/profilestats] Computed stats in 1933ms, got 50 top albums, 50 top performers, 100 genres
03/19 00:25:28 Trace: [dbperf] flush 0 bytes, 0 ops in 3515 ms (cumulative 40515164 bytes, 36637 ops in 187719 ms)
03/19 00:25:28 Trace: [library] endmutation in 11321ms
03/19 00:25:28 Trace: [library] finished with 2 dirty performers 1 dirty places 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 2 changed objects
03/19 00:25:28 Trace: [dbperf] flush 0 bytes, 0 ops in 2 ms (cumulative 40515164 bytes, 36637 ops in 187721 ms)
03/19 00:25:28 Trace: [library] endmutation in 21ms
03/19 00:25:28 Trace: [dbperf] flush 0 bytes, 0 ops in 1 ms (cumulative 40515164 bytes, 36637 ops in 187722 ms)
03/19 00:25:28 Info: [library/albumdetails] found 1 ingroup alternates, 0 other alternates
03/19 00:25:28 Info: [library/albumdetails] Created album details screen for LibraryAlbum[4630575, The Modern Lovers, Jonathan Richman - The Modern Lovers (Expanded Version)]
03/19 00:25:28 Info: [library/albumdetails] 79004d5730303030363534333638, 79004d5230303031323937393634, 79004d5230303030373238313231, 79004d5230303034343330333532, 79004d5230303034353532373631, 79004d5230303033333233363333, 79004d5230303034363035383130, 79004d5230303031353233393134, 79004d5230303031353232363232, 79004d5230303031343238323439, 79004d5230303030323331333539, 79004d5230303035323837353630, 79004d5230303035303532313938, 79004d5230303030353332343535, 3e012d1ff2cac53b13439126902a2ae45851, 79004d5230303034393231353634, 3e01cb976d4d278cbf448281bf8329445c32, 3e01bee70e85e52ba737954e6a50cb1d9ce4, 3e01f6fe8d8edf6ae33489a937e920f1c9e6, 3e01c11db8655a7c084eb2aedb4bf77acf53, 3e0157d97140c31a353f9437c06d364ea8a3, 3e010be38028513ac034b1e82105b2a344a4, 3e010b65620a360b99308c57495409c80b48, 3e018c6f2a43d4f2a3428fffaf6032895de9, 3e01b41ea65358b34248b57e06c233c2bbd6, 3e017b42ab06b4062a4890c34981c294eadd, 3e019a3e5733c54e8d429f734f25839576ab, 3e0135af4347f5a17a4b9b22e3818f07988f, 79004d5230303031333031363030, 3e01f05c124ead301644ac615e913c130623, a6003633383839303535, c80035343134393339343831343735, cd00536f727038653039464f6348633852663550
03/19 00:25:28 Trace: [dbperf] flush 0 bytes, 0 ops in 2 ms (cumulative 40515164 bytes, 36637 ops in 187724 ms)
03/19 00:25:28 Trace: [dbperf] flush 0 bytes, 0 ops in 1 ms (cumulative 40515164 bytes, 36637 ops in 187725 ms)
03/19 00:25:28 Info: [library] saved recent ProfileId=7fe3c25a-5754-428c-9ce8-1de03e5b7a1d Time=03/19/2023 00:25:28 DataType=album Type=long_nav MetadataId=1082745 ContentId=1082745 LibraryId=4630575 Text= Genre=
03/19 00:25:28 Info: [Lounge] [zoneplayer] Playing: https://streaming-qobuz-std.akamaized.net/file
03/19 00:25:28 Trace: [Lounge] [Enhanced, 16/44 QOBUZ FLAC => 32/44] [14% buf] [LOADING @ 0:00] Roadrunner - The Modern Lovers / Jonathan Richman & The Modern Lovers
03/19 00:25:28 Info: [Lounge] [zoneplayer] Queueing: https://streaming-qobuz-std.akamaized.net/file
03/19 00:25:28 Info: FTMSI-B new FileCache qo/311EC8C1
>>> /roon/data/RoonServer/Cache/smc.db/bfc/160.cache
>>> https://streaming-qobuz-std.akamaized.net/file
03/19 00:25:28 Debug: FTMSI-B Cache open file qo/311EC8C1 domain: zoneplayer:6 ordinal:265
03/19 00:25:28 Debug: FTMSI-B qo/311EC8C1 download status: DownloadNotStarted accessTimeout:False openFiles:1 prev:no
03/19 00:25:28 Info: FTMSI-B qo/311EC8C1: allocated bw changed from 0 to 51200 kbps
03/19 00:25:28 Info: FTMSI-B 1 FileCache qo/C4DB1811 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':76) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B 2 FileCache qo/311EC8C1 dwStatus:DownloadNotStarted files:1 accessTimeOut:False priorities: ('zoneplayer:6':265) --> bw limit:51200kbps
03/19 00:25:28 Info: FTMSI-B 3 FileCache qo/C2FD93FA dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':264) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B 4 FileCache qo/84AD66FA dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':77) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B 5 FileCache qo/D0231F6B dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:4':19) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B 6 FileCache qo/D00A5021 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1':5) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B 7 FileCache qo/E5F49723 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1':6) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B 8 FileCache qo/C87CD0E5 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:4':20) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B 9 FileCache qo/A589395F dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:40':1) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B 10 FileCache qo/E6B6D01D dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:40':2) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B 11 FileCache qo/D2273969 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':263) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B FileCache removed qo/D2273969
03/19 00:25:28 Debug: FTMSI-B-OE qo/D2273969 exit thread signalled
03/19 00:25:28 Trace: FTMSI-B 1 FileCache qo/C4DB1811 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':76) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 2 FileCache qo/311EC8C1 dwStatus:DownloadNotStarted files:1 accessTimeOut:False priorities: ('zoneplayer:6':265) --> bw limit:51200kbps
03/19 00:25:28 Debug: FTMSI-B-OE qo/D2273969 exit thread signalled
03/19 00:25:28 Trace: FTMSI-B 3 FileCache qo/C2FD93FA dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:6':264) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 4 FileCache qo/84AD66FA dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':77) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 5 FileCache qo/D0231F6B dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:4':19) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 6 FileCache qo/D00A5021 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1':5) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 7 FileCache qo/E5F49723 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1':6) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 8 FileCache qo/C87CD0E5 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:4':20) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 9 FileCache qo/A589395F dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:40':1) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 10 FileCache qo/E6B6D01D dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:40':2) --> bw limit:0kbps
03/19 00:25:28 Debug: FTMSI-B-OE qo/311EC8C1 created new req 1 for block 0 p 4294967295; active requests 1
03/19 00:25:28 Info: FTMSI-B new FileCache qo/C5FC553C
>>> /roon/data/RoonServer/Cache/smc.db/bfc/161.cache
>>> https://streaming-qobuz-std.akamaized.net/file
03/19 00:25:28 Debug: FTMSI-B Cache open file qo/C5FC553C domain: zoneplayer:6 ordinal:266
03/19 00:25:28 Debug: FTMSI-B qo/C5FC553C download status: DownloadNotStarted accessTimeout:False openFiles:1 prev:no
03/19 00:25:28 Info: FTMSI-B FileCache removed qo/C2FD93FA
03/19 00:25:28 Debug: FTMSI-B-OE qo/C2FD93FA exit thread signalled
03/19 00:25:28 Trace: FTMSI-B 1 FileCache qo/C4DB1811 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':76) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 2 FileCache qo/311EC8C1 dwStatus:DownloadNotStarted files:1 accessTimeOut:False priorities: ('zoneplayer:6':265) --> bw limit:51200kbps
03/19 00:25:28 Trace: FTMSI-B 3 FileCache qo/84AD66FA dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:30':77) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 4 FileCache qo/D0231F6B dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:4':19) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 5 FileCache qo/D00A5021 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1':5) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 6 FileCache qo/E5F49723 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:1':6) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 7 FileCache qo/C87CD0E5 dwStatus:AllBlocksDownloaded files:0 accessTimeOut:True priorities: ('zoneplayer:4':20) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 8 FileCache qo/A589395F dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:40':1) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 9 FileCache qo/E6B6D01D dwStatus:FirstBlockRetrieved files:0 accessTimeOut:True priorities: ('zoneplayer:40':2) --> bw limit:0kbps
03/19 00:25:28 Trace: FTMSI-B 10 FileCache qo/C5FC553C dwStatus:DownloadNotStarted files:1 accessTimeOut:False priorities: ('zoneplayer:6':266) --> bw limit:0kbps
03/19 00:25:28 Info: FTMSI-B FileCache disposed qo/D2273969
03/19 00:25:28 Debug: FTMSI-B-OE qo/C2FD93FA exit thread signalled
03/19 00:25:28 Info: FTMSI-B FileCache disposed qo/C2FD93FA
03/19 00:25:28 Debug: [easyhttp] [8622] GET to https://www.qobuz.com/api.json/0.2/album/get?album_id=5414939481475&limit=0&offset=0&request_sig=5b8cdbad85a2195e61c540cdbf5ec437&request_ts=1679185528 returned after 122 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Info: [library/albumdetails] found 1 ingroup alternates, 0 other alternates
03/19 00:25:28 Info: [library/albumdetails] found 1 streaming service alternates
03/19 00:25:28 Debug: [easyhttp] [8626] GET to https://streaming-qobuz-std.akamaized.net/file?uid=355122&eid=11007251&fmt=6&profile=raw&app_id=188245549&cid=1632289&etsp=1679189116&hmac=zK_aZbAUd-Ygb5xW5F1Qpgnb68c returned after 89 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Debug: FTMSI-B got length for qo/311EC8C1; 29.2 MBytes
03/19 00:25:28 Debug: FTMSI-B qo/311EC8C1 download status: FileLengthRetrieved accessTimeout:False openFiles:1 prev:(DownloadNotStarted,False,1)
03/19 00:25:28 Debug: FTMSI-B-OE set min bandwidth for qo/311EC8C1 to 1164 kbps
03/19 00:25:28 Info: FTMSI-B-OE qo/311EC8C1 rid:1 response took 90ms
03/19 00:25:28 Debug: FTMSI-B qo/311EC8C1 download status: FirstBlockRetrieved accessTimeout:False openFiles:1 prev:(FileLengthRetrieved,False,1)
03/19 00:25:28 Trace: GetImageData[Remote](id=23902 spec=1by1_512 key=ijjbaaaa uri=https://imagecache.roonlabs.net/im/1/artists/7a004d4e30303030353730383235/avatar/1by1_512.jpg) => fetched in 85ms status=200 size=71941 overalltime=98ms
03/19 00:25:28 Debug: [easyhttp] [8621] POST to https://api.roonlabs.net/metadata/1/albums/translate?c=qobuz-gb returned after 162 ms, status code: 200, request body size: 1 KB
03/19 00:25:28 Trace: GetImageData[Remote](id=23903 spec=16by7_2048 key=jjjbaaaa uri=https://imagecache.roonlabs.net/im/1/artists/7a004d4e30303030353730383235/photo/16by7_2048.jpg) => fetched in 83ms status=200 size=195282 overalltime=109ms
03/19 00:25:28 Debug: [easyhttp] [8620] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=174:1:4659f259-88f4-3e40-970d-12ccd79362b7&type=description&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 355 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Trace: GetImageData[Remote](id=23902 spec=1by1_256 key=ijjbaaaa uri=https://imagecache.roonlabs.net/im/1/artists/7a004d4e30303030353730383235/avatar/1by1_256.jpg) => fetched in 187ms status=304 size=0 overalltime=188ms
03/19 00:25:28 Info: [library/albumdetails] found 1 ingroup alternates, 0 other alternates
03/19 00:25:28 Info: [library/albumdetails] found 1 streaming service alternates
03/19 00:25:28 Trace: GetImageData[Remote](id=23903 spec=4by3_2048 key=jjjbaaaa uri=https://imagecache.roonlabs.net/im/1/artists/7a004d4e30303030353730383235/photo/4by3_2048.jpg) => fetched in 186ms status=200 size=272235 overalltime=215ms
03/19 00:25:28 Debug: [easyhttp] [8618] POST to https://api.roonlabs.net/browse/1/works/trackCounts?c=qobuz-gb returned after 386 ms, status code: 200, request body size: 1 KB
03/19 00:25:28 Debug: [easyhttp] [8619] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=121:0:MW0000654368&type=review&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 398 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Debug: [easyhttp] [8633] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=191:0:587887&type=biography&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 278 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Info: [Lounge] [zoneplayer]     Open Result (Playing):Result[Status=Success]
03/19 00:25:28 Info: [Lounge] [zoneplayer] Starting playback
03/19 00:25:28 Trace: [prebuffer] ready 149940/441000 (34%) @ 0/246 sec
03/19 00:25:28 Debug: [convolution] performing convolution with 2 paths
03/19 00:25:28 Trace: [Lounge] [zoneplayer/raat] StartStream Sooloos.Broker.Transport.RaatZonePlayer+Endpoint: StreamFormat(channels=2, bitspersample=16, samplerate=44100, isdts=False) => StreamFormat(channels=2, bitspersample=32, samplerate=44100, isdts=False) streamid=1944495738
03/19 00:25:28 Info: [zone Lounge] OnPlayFeedback Playing
03/19 00:25:28 Trace: [Lounge] [Enhanced, 16/44 QOBUZ FLAC => 32/44] [14% buf] [PLAYING @ 0:00] Roadrunner - The Modern Lovers / Jonathan Richman & The Modern Lovers
03/19 00:25:28 Trace: [roonapi] [apiclient 192.168.5.227:43560] CONTINUE Changed {"zones_changed":[{"zone_id":"16018ff03739b586694b96eacb45c8a7939b","display_name":"Lounge","outputs":[{"output_id":"17018ff03739b586694b96eacb45c8a7939b","zone_id":"16018ff03739b586694b96eacb45c8a7939b","can_group_with_output_ids":["1701ce3d361363a043e28fa9ed5974675222","170195a9d03729bac7c5e441ca8183a560df","17018ff03739b586694b96eacb45c8a7939b","1701e4ed5ea97ad7acd7062abf21ed9e1ae5"],"display_name":"Lounge","volume":{"type":"number","min":0,"max":100,"value":33,"step":1,"is_muted":false,"hard_limit_min":0,"hard_limit_max":50,"soft_limit":40},"source_controls":[{"control_key":"1","display_name":"Naim Audio Uniti Atom","supports_standby":true,"status":"selected"}]}],"state":"playing","is_next_allowed":true,"is_previous_allowed":true,"is_pause_allowed":true,"is_play_allowed":false,"is_seek_allowed":true,"queue_items_remaining":17,"queue_time_remaining":3739,"settings":{"loop":"disabled","shuffle":false,"auto_radio":false},"now_playing":{"seek_position":null,"length":246,"one_line":{"line1":"Roadrunner - The Modern Lovers / Jonathan Richman & The Modern Lovers"},"two_line":{"line1":"Roadrunner","line2":"The Modern Lovers / Jonathan Richman & The Modern Lovers"},"three_line":{"line1":"Roadrunner","line2":"The Modern Lovers / Jonathan Richman & The Modern Lovers","line3":"The Modern Lovers (Expanded Version)"},"image_key":"c3556660d3aa5f99086575addd7e5d6a","artist_image_keys":["3ab6f0986d3231fb10b80d963af40785","31248a0d1d4821a94d5479dff9d44458","f8c123ca06cf6160c2515b80e3d8d491"]}}]}
03/19 00:25:28 Trace: [Lounge] [zoneplayer/raat] synced to endpoint Naim Audio Uniti Atom clock: realtime=626637806635126 rtt=0us offset=532771310635us delta=532771310635us
03/19 00:25:28 Trace: [Naim Audio Uniti Atom @ 192.168.5.8:50759] [raatclient] SENT [24207]{"request":"stream","stream_id":1944495738,"first_seq":-1,"nak_port":-1,"buffer_size":10,"ready_threshold":0.2}
03/19 00:25:28 Trace: [Naim Audio Uniti Atom @ 192.168.5.8:50759] [raatclient] GOT [24207] {"status":"Buffering"}
03/19 00:25:28 Trace: [Lounge] [zoneplayer/raat] Endpoint Naim Audio Uniti Atom State Changed: Prepared => Buffering
03/19 00:25:28 Trace: [Lounge] [zoneplayer/raat] [zoneplayer/raat] selected Naim Audio Uniti Atom as clock master
03/19 00:25:28 Debug: [raat/tcpaudiosource] connecting to 192.168.5.8:52909
03/19 00:25:28 Debug: [raat/tcpaudiosource] connected
03/19 00:25:28 Debug: [easyhttp] [8623] POST to https://api.roonlabs.net/browse/1/works/trackCounts?c=qobuz-gb returned after 373 ms, status code: 200, request body size: 1 KB
03/19 00:25:28 Debug: [easyhttp] [8624] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=121:0:MW0000654368&type=review&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 407 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Debug: [easyhttp] [8629] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=191:0:587886&type=biography&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 380 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Debug: [easyhttp] [8632] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=191:0:587886&type=biography&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 379 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Trace: [dbperf] flush 0 bytes, 0 ops in 3 ms (cumulative 40515164 bytes, 36637 ops in 187728 ms)
03/19 00:25:28 Debug: [easyhttp] [8637] POST to https://www.qobuz.com/api.json/0.2/track/reportStreamingStart? returned after 103 ms, status code: 201, request body size: 358 B
03/19 00:25:28 Trace: [Naim Audio Uniti Atom @ 192.168.5.8:50759] [raatclient] GOT [24207] {"status":"Ready"}
03/19 00:25:28 Trace: [Lounge] [zoneplayer/raat] Endpoint Naim Audio Uniti Atom State Changed: Buffering => Ready
03/19 00:25:28 Trace: [Lounge] [zoneplayer/raat] wait for ready in 21ms
03/19 00:25:28 Trace: [Lounge] [zoneplayer/raat] Adjusting playback start offset from 50ms to 650ms
03/19 00:25:28 Trace: [Lounge] [zoneplayer/raat] Doing 'ASAP' Start since we are just playing to one device
03/19 00:25:28 Trace: [Naim Audio Uniti Atom @ 192.168.5.8:50759] [raatclient] SENT [24208]{"request":"start","min_offset":650000000,"stream_sample":0}
03/19 00:25:28 Trace: [Lounge] [zoneplayer/raat] Endpoint Naim Audio Uniti Atom State Changed: Ready => Playing
03/19 00:25:28 Trace: [Naim Audio Uniti Atom @ 192.168.5.8:50759] [raatclient] GOT [24207] {"status":"Playing"}
03/19 00:25:28 Trace: [Naim Audio Uniti Atom @ 192.168.5.8:50759] [raatclient] GOT [24208] {"status":"Success","time":626638586938006}
03/19 00:25:28 Debug: [easyhttp] [8630] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=191:0:587887&type=biography&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 520 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Debug: [easyhttp] [8625] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=174:1:4659f259-88f4-3e40-970d-12ccd79362b7&type=description&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 627 ms, status code: 200, request body size: 0 B
03/19 00:25:28 Debug: [easyhttp] [8631] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=191:0:678206&type=biography&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 658 ms, status code: 200, request body size: 0 B
03/19 00:25:29 Info: 
--[ SignalPath ]---------------------------------------------
SignalPath Quality = Enhanced
Elements:
    Source Format=Flac 44100/16/2  Quality=Lossless
    UpgradeBitDepth FromBitsPerSample=16 ToBitsPerSample=64 Quality=Lossless
    VolumeNormaliation GainDb=-7.359999999999999 Quality=Enhanced
    Convolution
    Truncate FromBitsPerSample=64 ToBitsPerSample=32 Quality=Lossless
    Raat Device=Naim Audio Uniti Atom
    Amplifier Method=analog Quality=Lossless
    Output OutputType=Local_Analog Quality=Lossless SubType= Model=
------------------------------------------------------------
03/19 00:25:29 Debug: [easyhttp] [8628] GET to https://api.roonlabs.net/metadatatext/1/blobs?objectId=191:0:678206&type=biography&sourceLangs=Rovi-albums:en,Wikipedia:en,Rovi-artists:en,Rovi-compositions:en&c=qobuz-gb&contentPreferences=avoidMqa returned after 837 ms, status code: 200, request body size: 0 B
03/19 00:25:30 Debug: FTMSI-B qo/311EC8C1 download status: FirstBlockRetrieved accessTimeout:True openFiles:1 prev:(FirstBlockRetrieved,False,1)
03/19 00:25:31 Trace: [zone Lounge] PlayPause
03/19 00:25:31 Trace: [zone Lounge] Pause
03/19 00:25:31 Info: [zone Lounge] Canceling Pending Sleep
03/19 00:25:31 Trace: [Lounge] [zoneplayer/raat] Pausing at streamtime_ns 1656698592 now_ns 626640243636598
03/19 00:25:31 Trace: [Naim Audio Uniti Atom @ 192.168.5.8:50759] [raatclient] SENT [24211]{"request":"stop"}
03/19 00:25:31 Trace: [Lounge] [zoneplayer/raat] Endpoint Naim Audio Uniti Atom State Changed: Playing => Paused
03/19 00:25:31 Info: [zone Lounge] OnPlayFeedback Paused
03/19 00:25:31 Trace: [Lounge] [Enhanced, 16/44 QOBUZ FLAC => 32/44] [100% buf] [PAUSED @ 0:01/4:06] Roadrunner - The Modern Lovers / Jonathan Richman & The Modern Lovers

Looking at my logs Qobuz isnt buffering for some reason I hit play at 25:16 yet it doesnt play until :35:31 . I had no loss of internet here so what can explain this? I have had this on skipping local tracks to on different zones.

Hi @CrystalGipsy ,

Thanks for the report. I just spoke to the team regarding this issue, and we are looking into this. If you are still seeing this issue at the present time, would you please be able to send us your database for testing?

https://workdrive.zohoexternal.com/collection/gnhz54df9ddffa33d49a3be8619bd6376a5de/external

Not had this repeat since the last update but I have not been using Roon so much over last week or so to tell. Will see if I can repeat. However search has become very very slow. I’ll upload my db for you though.

@noris database uploaded, be good to know if this has any issues.

1 Like

Hey @CrystalGipsy ,

I just wanted to check in with you regarding this issue since our last release had a fix in this area. Has the issue been resolved on your end since updating?

Not noticed any slow changes or pauses. But will keep an eye/ear out. But so far so good.

1 Like

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