Metadata not available on most stations

Michael_Curtis · February 14, 2023, 10:15am

Hi - I’m in the UK and about an hour ago, metadata was working on Radio Paradise Mellow Mix, albeit a song or two behind.
Now, however, I’m getting no metadata at all, across several stations that usually supply it.
I’ve restarted the server software, and also rebooted ROCK, to no avail.
Any thoughts? Anyone else with the same issue?

Michael

alec_eiffel · February 14, 2023, 10:40am

I’ve done some updates on my master server this morning that unexpectedly caused the Roon slave server to go nuts… I think I’ve understood the issue, hold your breath…

Michael_Curtis · February 14, 2023, 10:56am

All working again now Alec - thanks for the update.

Michael

alec_eiffel · February 14, 2023, 10:59am

Not completely recovered unfortunately, some instability in the system… I stay on it.

alec_eiffel · February 14, 2023, 3:35pm

@nathan can you check if all is good on your side? Some stations like FIP Reggae show metadata on Roon client, others (FIP) don’t… Checking on the internet directory the Roon backend seem to operate as normal. Or is it a connectivity issue between Roon client and Roon backend? http server not coping with the traffic?
Checking again, Radio Paradise Rock Mix shows metadata, Radio Paradise doesn’t…

ToneDeaf · February 14, 2023, 3:46pm

Just before seeing this thread I wondered why the BBC6 music 320kbps stream in the UK is currently not providing metadata for me. Probably same issue.

nathan · February 14, 2023, 3:47pm

I’ll check this out. Was your system having trouble for some time @alec_eiffel ?

alec_eiffel · February 14, 2023, 3:52pm

From this morning

Michael_Curtis · February 14, 2023, 3:56pm

Ah yes. I only checked Radio Paradise main and mellow mixes. They seemed ok with the brief look I had earlier, but I see most of the stations I have saved which usually have metadata mostly still don’t.
Thanks for looking into it though.

Michael

nathan · February 14, 2023, 6:58pm

The metadata looks good on the system for FIP and Radio Paradise both from the data side and from client side at least on my system. Are we still seeing this?

AndyR · February 14, 2023, 7:05pm

BBC R3 in the UK is now showing metadata again

darkj2k · February 15, 2023, 1:39pm

All my live radio with keywords of METADATA SERVICE are not showing metadata but just station logo. What could go wrong? Any port or server address should i check in case it was blocked by firewall?
@support

alec_eiffel · February 15, 2023, 1:56pm

As I type, Radio Paradise Main works, but FIP, BBC RAdio 6 Music, BBC Radio 1 Dance don’t… Yesterday evening everything was OK.
Checking at the logs I can see that metadata were fetched but there is a critical error…
FWIW I am running Early Access.

02/15 14:50:57 Debug: [easyhttp] [131] GET to https://api.roonlabs.net/internetradio/2/api/stations/e65c2cff-629e-4caf-ba7b-5314b58f1a1d/metadata?format=msgpack&wait=True&timestamp=-1& returned after 134 ms, status code: 200, request body size: 0 B
02/15 14:50:57 Debug: [easyhttp] [133] GET to https://api.roonlabs.net/search/1/internetradiosearch?q=BadBadNotGood%20%26%20Matthew%20Tavares%20%26%20Chester%20Hansen%20%26%20Alexander%20Sowinski%20%26%20Leland%20Whitty%20-%20Limit%20to%20your%20love&count=50&c=qobuz-fr returned after 202 ms, status code: 200, request body size: 0 B
02/15 14:50:57 Debug: [easyhttp] [130] POST to https://api.roonlabs.net/internetradio/2/api/reporting/internetradioplayback/events?format=msgpack& returned after 377 ms, status code: 200, request body size: 172 B
02/15 14:50:58 Info:
–[ SignalPath ]---------------------------------------------
SignalPath Quality = LowQuality
Elements:
Source Format=Aac 48000/24/2 Quality=LowQuality
Raat Device=System Output
Output OutputType=Local_SharedMode_Wasapi Quality=HighQuality SubType= Model=System Output
02/15 14:50:58 Trace: [music/search] [performance][internetradio] end-to-end search took 380ms
02/15 14:50:58 Critical: scx: System.InvalidCastException: Impossible d’effectuer un cast d’un objet de type ‘Sooloos.Broker.Metadata.MetadataAlbumLite’ en type ‘Sooloos.Broker.Music.LibraryAlbum’.
** à Sooloos.Broker.Music.Module.<>c__DisplayClass40_3.b__10(String seg)**
** à System.Linq.Enumerable.All[TSource](IEnumerable1 source, Func2 predicate)**
** à Sooloos.Broker.Music.Module.<>c__DisplayClass40_1.b__1(Result`1 result)**
** à Sooloos.SynchronizationContextThread._Dispatch(SendOrPostWrapper& ret)**

alec_eiffel · February 15, 2023, 9:09pm

@nathan no metadata tonight on any of the channels I’ve tried. See the extract of RoonServer logs when I launch playback for FIP.

02/15 18:28:11 Debug: [easyhttp] [2693] POST to https://api.roonlabs.net/swim/1/session/4e71357c103b41798ccb3da1f8fcfa30/ping returned after 339 ms, status code: 200, request body size: 2 B
02/15 18:28:12 Debug: [easyhttp] [2695] GET to https://api.roonlabs.net/internetradio/2/api/stations/e65c2cff-629e-4caf-ba7b-5314b58f1a1d?format=msgpack& returned after 339 ms, status code: 200, request body size: 0 B
02/15 18:28:12 Trace: [zone Séjour] Playing Channel
02/15 18:28:12 Trace: [zone Séjour] Selecting Source state=Stopped
02/15 18:28:12 Info: [library] saved recent ProfileId=0b10440b-2c35-4a29-90bd-3bc2952f0321 Time=15/02/2023 17:28:12 DataType=channel Type=play MetadataId=1826 ContentId= LibraryId=1826 Text= Genre=
02/15 18:28:12 Trace: [Séjour] [LowQuality, 24/48 AAC => 32/48 8ch] [100% buf] [LOADING @ 0:00] FIP
02/15 18:28:12 Trace: [internetradio] Channel Player: Fetching URL [https://icecast.radiofrance.fr/fip-hifi.aac?id=radiofrance]
02/15 18:28:12 Debug: [easyhttp] [2696] GET to https://icecast.radiofrance.fr/fip-hifi.aac?id=radiofrance returned after 144 ms, status code: 200, request body size: 0 B
02/15 18:28:12 Trace: [internetradio] Channel Player: Fetching URL [https://icecast.radiofrance.fr/fip-midfi.mp3?id=radiofrance]
02/15 18:28:13 Debug: [easyhttp] [2697] GET to https://icecast.radiofrance.fr/fip-midfi.mp3?id=radiofrance returned after 154 ms, status code: 200, request body size: 0 B
02/15 18:28:13 Trace: Attempting to play channel URL: icy://icecast.radiofrance.fr/fip-hifi.aac?id=radiofrance
02/15 18:28:13 Info: [Séjour] [zoneplayer] Playing: channel://icy%3a%2f%2ficecast.radiofrance.fr%2ffip-hifi.aac%3fid%3dradiofrance
02/15 18:28:13 Info: [Séjour] [zoneplayer]     Open Result (Playing):Result[Status=Success]
02/15 18:28:13 Info: [Séjour] [zoneplayer] Starting playback
02/15 18:28:13 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:13 Info: [audio/env] [env000374] All streams were disposed
02/15 18:28:13 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:13 Info: [audio/env] [env000375] All streams were disposed
02/15 18:28:13 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:13 Info: [audio/env] [env000376] All streams were disposed
02/15 18:28:13 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:13 Info: [audio/env] [env000377] All streams were disposed
02/15 18:28:13 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:13 Info: [audio/env] [env000378] All streams were disposed
02/15 18:28:13 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:13 Info: [audio/env] [env000379] All streams were disposed
02/15 18:28:14 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:14 Info: [audio/env] [env000380] All streams were disposed
02/15 18:28:14 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:14 Info: [audio/env] [env000381] All streams were disposed
02/15 18:28:14 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:14 Info: [audio/env] [env000382] All streams were disposed
02/15 18:28:14 Info: 
--[ SignalPath ]---------------------------------------------
SignalPath Quality = LowQuality
Elements:
    Source Format=Aac 48000/24/2  Quality=LowQuality
    UpgradeBitDepth FromBitsPerSample=24 ToBitsPerSample=64 Quality=Lossless
    HeadroomGain GainDb=-2 Quality=Enhanced
    Convolution
    SpeakerSetup HasDistanceAdjustment=False HasGainAdjustment=True HasPhaseAdjustment=False
    Truncate FromBitsPerSample=64 ToBitsPerSample=32 Quality=Lossless
    SpeakerSetup HasDistanceAdjustment=True HasGainAdjustment=False HasPhaseAdjustment=True
    Raat Device=exaSound ASIO64 (8ch)
    Output OutputType=Local_Asio Quality=Lossless SubType= Model=exaSound ASIO64 (8ch)
------------------------------------------------------------
02/15 18:28:14 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:14 Info: [audio/env] [env000383] All streams were disposed
02/15 18:28:14 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:14 Info: [audio/env] [env000384] All streams were disposed
02/15 18:28:14 Trace: [convolution] resampled 262144 samples to 32935 samples using linear_phase_precise (384000 => 48000)
02/15 18:28:14 Info: [audio/env] [env000385] All streams were disposed
02/15 18:28:14 Trace: [convolution] normalized norm=7,99999999681009 before -0,0724674705415964 after -0,0724674705415981
02/15 18:28:14 Debug: [convolution] adjusted filter length from 32935 to 28521 since filter had trailing zeroes
02/15 18:28:14 Debug: [convolution] performing convolution with 12 paths
02/15 18:28:14 Trace: [Séjour] [zoneplayer/raat] StartStream Sooloos.Broker.Transport.RaatZonePlayer+Endpoint: StreamFormat(channels=2, bitspersample=24, samplerate=48000, isdts=False) => StreamFormat(channels=8, bitspersample=32, samplerate=48000, isdts=False) streamid=765966170
02/15 18:28:14 Trace: [exaSound ASIO64 (8ch)] [raatclient] SENT [155]{"request":"setup","format":{"sample_type":"pcm","sample_rate":48000,"bits_per_sample":32,"channels":8,"sample_subtype":"none"}}
02/15 18:28:14 Info: [zone Séjour] OnPlayFeedback Playing
02/15 18:28:14 Trace: [Séjour] [LowQuality, 24/48 AAC => 32/48 8ch] [100% buf] [PLAYING @ 0:00] FIP
02/15 18:28:14 Trace: [exaSound ASIO64 (8ch)] [raatclient] GOT [155] {"status":"OutputMessage","message":{"signal_path":[{"type":"output","quality":"lossless","method":"asio"}]}}
02/15 18:28:14 Debug: [easyhttp] [2698] GET to https://api.roonlabs.net/internetradio/2/api/stations/e65c2cff-629e-4caf-ba7b-5314b58f1a1d/metadata?format=msgpack&wait=False&timestamp=-1& returned after 136 ms, status code: 200, request body size: 0 B
02/15 18:28:14 Trace: [music/search] starting internet radio search
02/15 18:28:14 Trace: [exaSound ASIO64 (8ch)] [raatclient] GOT [155] {"status":"Success","audio_port_tcp":49877,"audio_port":0,"clock_port":59460}
02/15 18:28:14 Trace: [Séjour] [zoneplayer/raat] Endpoint exaSound ASIO64 (8ch) State Changed: Idle => Prepared
02/15 18:28:14 Trace: [Séjour] [zoneplayer/raat] pausing for 0,05s for server-side resync delay
02/15 18:28:14 Trace: [Séjour] [zoneplayer/raat] synced to endpoint exaSound ASIO64 (8ch) clock: realtime=22322170043667 rtt=0us offset=-53134344956us delta=-53134344956us
02/15 18:28:14 Trace: [exaSound ASIO64 (8ch)] [raatclient] SENT [156]{"request":"stream","stream_id":765966170,"first_seq":-1,"nak_port":-1,"buffer_size":10,"ready_threshold":0.2}
02/15 18:28:14 Trace: [exaSound ASIO64 (8ch)] [raatclient] GOT [156] {"status":"Buffering"}
02/15 18:28:14 Trace: [Séjour] [zoneplayer/raat] Endpoint exaSound ASIO64 (8ch) State Changed: Prepared => Buffering
02/15 18:28:14 Trace: [Séjour] [zoneplayer/raat] [zoneplayer/raat] selected exaSound ASIO64 (8ch) as clock master
02/15 18:28:14 Debug: [raat/tcpaudiosource] connecting to 127.0.0.1:49877
02/15 18:28:14 Debug: [raat/tcpaudiosource] connected
02/15 18:28:14 Debug: [easyhttp] [2700] GET to https://api.roonlabs.net/internetradio/2/api/stations/e65c2cff-629e-4caf-ba7b-5314b58f1a1d/metadata?format=msgpack&wait=True&timestamp=-1& returned after 138 ms, status code: 200, request body size: 0 B
02/15 18:28:14 Trace: [exaSound ASIO64 (8ch)] [raatclient] GOT [156] {"status":"Ready"}
02/15 18:28:14 Trace: [Séjour] [zoneplayer/raat] Endpoint exaSound ASIO64 (8ch) State Changed: Buffering => Ready
02/15 18:28:14 Debug: [easyhttp] [2699] POST to https://api.roonlabs.net/internetradio/2/api/reporting/internetradioplayback/events?format=msgpack& returned after 354 ms, status code: 200, request body size: 172 B
02/15 18:28:14 Debug: [easyhttp] [2702] GET to https://api.roonlabs.net/search/1/internetradiosearch?q=Kevin%20Godley%20-%20Expecting%20a%20message&count=50&c=qobuz-fr returned after 228 ms, status code: 200, request body size: 0 B
02/15 18:28:14 Trace: [music/search] [performance][internetradio] end-to-end search took 348ms
02/15 18:28:14 Critical: scx: System.InvalidCastException: Impossible d'effectuer un cast d'un objet de type 'Sooloos.Broker.Metadata.MetadataAlbumLite' en type 'Sooloos.Broker.Music.LibraryAlbum'.
   à Sooloos.Broker.Music.Module.<>c__DisplayClass40_3.<FuzzyFindTrack>b__10(String seg)
   à System.Linq.Enumerable.All[TSource](IEnumerable`1 source, Func`2 predicate)
   à Sooloos.Broker.Music.Module.<>c__DisplayClass40_1.<FuzzyFindTrack>b__1(Result`1 result)
   à Sooloos.SynchronizationContextThread._Dispatch(SendOrPostWrapper& ret)
02/15 18:28:15 Trace: [Séjour] [zoneplayer/raat] wait for ready in 0ms
02/15 18:28:15 Trace: [Séjour] [zoneplayer/raat] Adjusting playback start offset from 50ms to 73ms
02/15 18:28:15 Trace: [Séjour] [zoneplayer/raat] Doing 'ASAP' Start since we are just playing to one device
02/15 18:28:15 Trace: [exaSound ASIO64 (8ch)] [raatclient] SENT [157]{"request":"start","min_offset":73333333,"stream_sample":0}
02/15 18:28:15 Trace: [Séjour] [zoneplayer/raat] Endpoint exaSound ASIO64 (8ch) State Changed: Ready => Playing
02/15 18:28:15 Trace: [exaSound ASIO64 (8ch)] [raatclient] GOT [156] {"status":"Playing"}
02/15 18:28:15 Trace: [exaSound ASIO64 (8ch)] [raatclient] GOT [157] {"status":"Success","time":22322741985000}
02/15 18:28:19 Trace: [Séjour] [LowQuality 32,8x, 24/48 AAC => 32/48 8ch] [100% buf] [PLAYING @ 0:04] FIP
02/15 18:28:22 Info: [stats] 6733mb Virtual, 1038mb Physical, 720mb Managed, 3009 Handles, 152 Threads

nathan · February 16, 2023, 3:59am

The metadata system is working but this problem is in the hands of the people who will be able to deliver a solution on this problem!

alec_eiffel · February 16, 2023, 8:41am

OK mode diagnosis points:

if I disable streaming service (Qobuz) I get metadata back…
enabling Qobuz again: no more metadata

See critical error in logs:

02/15 14:50:57 Debug: [easyhttp] [131] GET to https://api.roonlabs.net/internetradio/2/api/stations/e65c2cff-629e-4caf-ba7b-5314b58f1a1d/metadata?format=msgpack&wait=True&timestamp=-1& returned after 134 ms, status code: 200, request body size: 0 B
02/15 14:50:57 Debug: [easyhttp] [133] GET to https://api.roonlabs.net/search/1/internetradiosearch?q=BadBadNotGood%20%26%20Matthew%20Tavares%20%26%20Chester%20Hansen%20%26%20Alexander%20Sowinski%20%26%20Leland%20Whitty%20-%20Limit%20to%20your%20love&count=50&c=qobuz-fr returned after 202 ms, status code: 200, request body size: 0 B
02/15 14:50:57 Debug: [easyhttp] [130] POST to https://api.roonlabs.net/internetradio/2/api/reporting/internetradioplayback/events?format=msgpack& returned after 377 ms, status code: 200, request body size: 172 B
02/15 14:50:58 Info: 
--[ SignalPath ]---------------------------------------------
SignalPath Quality = LowQuality
Elements:
    Source Format=Aac 48000/24/2  Quality=LowQuality
    Raat Device=System Output
    Output OutputType=Local_SharedMode_Wasapi Quality=HighQuality SubType= Model=System Output
------------------------------------------------------------
02/15 14:50:58 Trace: [music/search] [performance][internetradio] end-to-end search took 380ms
02/15 14:50:58 Critical: scx: System.InvalidCastException: Impossible d'effectuer un cast d'un objet de type 'Sooloos.Broker.Metadata.MetadataAlbumLite' en type 'Sooloos.Broker.Music.LibraryAlbum'.
   à Sooloos.Broker.Music.Module.<>c__DisplayClass40_3.<FuzzyFindTrack>b__10(String seg)
   à System.Linq.Enumerable.All[TSource](IEnumerable`1 source, Func`2 predicate)
   à Sooloos.Broker.Music.Module.<>c__DisplayClass40_1.<FuzzyFindTrack>b__1(Result`1 result)
   à Sooloos.SynchronizationContextThread._Dispatch(SendOrPostWrapper& ret)

noris · December 1, 2023, 10:01pm

This issue should be solved, but do let me know if this is not the case.

system · December 3, 2023, 10:02am

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