Dec 16 21:13:02 hifiberry-amp volumio[1162]: info: [1765915982495] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: [1765915983306] [RadioParadise] received new metadata: {"time":217,"artist":"Bruce Cockburn","title":"The Whole Night Sky","album":"The Charity of Night","year":"1996","cover":"https://img.radioparadise.com/covers/l/9080.jpg","cover_med":"https://img.radioparadise.com/covers/m/9080.jpg","cover_small":"https://img.radioparadise.com/covers/s/9080.jpg"}
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 0
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreCommandRouter::servicePushState
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 0
Dec 16 21:13:03 hifiberry-amp volumio[1162]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"","albumart":"https://img.radioparadise.com/covers/l/9080.jpg","uri":"https://stream.radioparadise.com/mellow-flacm","name":"The Whole Night Sky","title":"The Whole Night Sky","artist":"Bruce Cockburn","album":"The Charity of Night","streaming":true,"disableUiControls":true,"duration":220,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2}
Dec 16 21:13:03 hifiberry-amp volumio[1162]: verbose: CURRENT POSITION 0
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreStateMachine::syncState stateService play
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreStateMachine::syncState currentStatus play
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: Received an update from plugin. extracting info from payload
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreStateMachine::pushState
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 0
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreCommandRouter::volumioPushState
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: MRS: Pushing multiroomSync output update for this device
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: MRS: Pushing multiroomSync output
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreCommandRouter::volumioGetState
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 0
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreStateMachine::pushState
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 0
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreCommandRouter::volumioPushState
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: MRS: Pushing multiroomSync output update for this device
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: MRS: Pushing multiroomSync output
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CoreCommandRouter::volumioGetState
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 0
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: [1765915983362] [RadioParadise] setting new timer with duration of 220000 seconds.
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: FusionDsp - volume level for loudness 20 gain applied 15.33
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: FusionDsp - crossfeed nc_11_50
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: FusionDsp - Loudness is ON true
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: FusionDsp - volume level for loudness 20 gain applied 15.33
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: FusionDsp - crossfeed nc_11_50
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: FusionDsp - Loudness is ON true
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 0
Dec 16 21:13:03 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 1
Dec 16 21:13:05 hifiberry-amp volumio[1162]: info: Executing endpoint metavolumio
Dec 16 21:13:05 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 16 21:13:05 hifiberry-amp volumio[1162]: info: Executing endpoint metavolumio
Dec 16 21:13:05 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 16 21:13:05 hifiberry-amp volumio[1162]: info: Executing endpoint metavolumio
Dec 16 21:13:05 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 16 21:13:08 hifiberry-amp volumio[1162]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 21:13:08 hifiberry-amp volumio[1162]: info: CoreCommandRouter::Close All Modals sent
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info:
Dec 16 21:13:12 hifiberry-amp volumio[1162]: ---------------------------- MPD announces system playlist update
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: Ignoring MPD Status Update
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info:
Dec 16 21:13:12 hifiberry-amp volumio[1162]: ---------------------------- MPD announces state update: player
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: ControllerMpd::getState
Dec 16 21:13:12 hifiberry-amp volumio[1162]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: ------------------------------ 2ms
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: sendMpdCommand status took 2 milliseconds
Dec 16 21:13:12 hifiberry-amp volumio[1162]: verbose: ControllerMpd::parseState
Dec 16 21:13:12 hifiberry-amp volumio[1162]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 16 21:13:12 hifiberry-amp volumio[1162]: verbose: ControllerMpd::parseTrackInfo
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: ControllerMpd::pushState
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: CoreCommandRouter::servicePushState
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 0
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Dec 16 21:13:12 hifiberry-amp volumio[1162]: info: ------------------------------ 4ms
Dec 16 21:13:46 hifiberry-amp volumio[1162]: info: CoreCommandRouter::volumioSaveQueueToPlaylist
Dec 16 21:13:46 hifiberry-amp volumio[1162]: info: CoreStateMachine::getQueue
Dec 16 21:13:46 hifiberry-amp volumio[1162]: info: CorePlayQueue::getQueue
Dec 16 21:13:46 hifiberry-amp volumio[1162]: info: Saving Cloud item Radio Paradise Mellow Mix
Dec 16 21:13:46 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: my_volumio , saveCloudItem
Dec 16 21:13:52 hifiberry-amp volumio[1162]: info: CoreCommandRouter::volumioGetState
Dec 16 21:13:52 hifiberry-amp volumio[1162]: info: CorePlayQueue::getTrack 0
Dec 16 21:13:54 hifiberry-amp volumio[1162]: info: Executing endpoint metavolumio
Dec 16 21:13:54 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 16 21:13:55 hifiberry-amp volumio[1162]: info: Executing endpoint metavolumio
Dec 16 21:13:55 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 16 21:13:55 hifiberry-amp volumio[1162]: info: Executing endpoint metavolumio
Dec 16 21:13:55 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 16 21:13:56 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 16 21:13:56 hifiberry-amp volumio[1162]: info: CURURI: playlists
Dec 16 21:13:56 hifiberry-amp volumio[1162]: info: Listing playlists
Dec 16 21:13:56 hifiberry-amp volumio[1162]: info: Preload queue cleared
Dec 16 21:13:57 hifiberry-amp volumio[1162]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 16 21:13:57 hifiberry-amp volumio[1162]: info: CURURI: playlists/Radio Paradise Mellow Mix
Dec 16 21:13:57 hifiberry-amp volumio[1162]: info: Preload queue cleared
Dec 16 21:13:57 hifiberry-amp volumio[1162]: info: Preloading song: https://stream.radioparadise.com/mellow-flacm
Dec 16 21:13:57 hifiberry-amp volumio[1162]: info: Exploding uri https://stream.radioparadise.com/mellow-flacm in service radio_paradise
Dec 16 21:13:57 hifiberry-amp volumio[1162]: error: [RadioParadise] explodeUri: No station found for uri "https://stream.radioparadise.com/mellow-flacm"
Dec 16 21:13:57 hifiberry-amp volumio[1162]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 21:13:57 hifiberry-amp volumio[1162]: TypeError: Cannot read properties of undefined (reading 'then')
Dec 16 21:13:57 hifiberry-amp volumio[1162]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:31)
Dec 16 21:13:57 hifiberry-amp volumio[1162]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Dec 16 21:13:57 hifiberry-amp volumio[1162]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Dec 16 21:13:57 hifiberry-amp volumio[1162]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100)
Dec 16 21:13:57 hifiberry-amp volumio[1162]: at listOnTimeout (node:internal/timers:573:17)
Dec 16 21:13:57 hifiberry-amp volumio[1162]: at process.processTimers (node:internal/timers:514:7)
Dec 16 21:13:57 hifiberry-amp volumio[1162]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 21:13:58 hifiberry-amp sudo[7271]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-16 21:12'
Dec 16 21:13:58 hifiberry-amp sudo[7271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"