Feb 26 20:38:10 volumio go-librespot[1568]: time="2026-02-26T20:38:10+03:00" level=trace msg="sent dealer ping"
Feb 26 20:38:10 volumio go-librespot[1568]: time="2026-02-26T20:38:10+03:00" level=trace msg="received dealer pong"
Feb 26 20:38:40 volumio go-librespot[1568]: time="2026-02-26T20:38:40+03:00" level=trace msg="sent dealer ping"
Feb 26 20:38:40 volumio go-librespot[1568]: time="2026-02-26T20:38:40+03:00" level=trace msg="received dealer pong"
Feb 26 20:39:10 volumio go-librespot[1568]: time="2026-02-26T20:39:10+03:00" level=trace msg="sent dealer ping"
Feb 26 20:39:10 volumio go-librespot[1568]: time="2026-02-26T20:39:10+03:00" level=trace msg="received dealer pong"
Feb 26 20:39:12 volumio volumio[1124]: info:
Feb 26 20:39:12 volumio volumio[1124]: ---------------------------- MPD announces system playlist update
Feb 26 20:39:12 volumio volumio[1124]: info: Ignoring MPD Status Update
Feb 26 20:39:12 volumio volumio[1124]: info:
Feb 26 20:39:12 volumio volumio[1124]: ---------------------------- MPD announces state update: player
Feb 26 20:39:12 volumio volumio[1124]: info: ControllerMpd::getState
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 20:39:12 volumio volumio[1124]: info:
Feb 26 20:39:12 volumio volumio[1124]: ---------------------------- MPD announces system playlist update
Feb 26 20:39:12 volumio volumio[1124]: info: Ignoring MPD Status Update
Feb 26 20:39:12 volumio volumio[1124]: info:
Feb 26 20:39:12 volumio volumio[1124]: ---------------------------- MPD announces state update: player
Feb 26 20:39:12 volumio volumio[1124]: info: ControllerMpd::getState
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 20:39:12 volumio volumio[1124]: info:
Feb 26 20:39:12 volumio volumio[1124]: ---------------------------- MPD announces system playlist update
Feb 26 20:39:12 volumio volumio[1124]: info: Ignoring MPD Status Update
Feb 26 20:39:12 volumio volumio[1124]: info:
Feb 26 20:39:12 volumio volumio[1124]: ---------------------------- MPD announces state update: player
Feb 26 20:39:12 volumio volumio[1124]: info: ControllerMpd::getState
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::sendMpdCommand status
Feb 26 20:39:12 volumio volumio[1124]: info: ------------------------------ 4ms
Feb 26 20:39:12 volumio volumio[1124]: info: sendMpdCommand status took 5 milliseconds
Feb 26 20:39:12 volumio volumio[1124]: info: ------------------------------ 4ms
Feb 26 20:39:12 volumio volumio[1124]: info: sendMpdCommand status took 5 milliseconds
Feb 26 20:39:12 volumio volumio[1124]: info: ------------------------------ 4ms
Feb 26 20:39:12 volumio volumio[1124]: info: sendMpdCommand status took 3 milliseconds
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::parseState
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::parseState
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::parseState
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 26 20:39:12 volumio volumio[1124]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 26 20:39:12 volumio volumio[1124]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 26 20:39:12 volumio volumio[1124]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::parseTrackInfo
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::parseTrackInfo
Feb 26 20:39:12 volumio volumio[1124]: verbose: ControllerMpd::parseTrackInfo
Feb 26 20:39:12 volumio volumio[1124]: info: ControllerMpd::pushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::servicePushState
Feb 26 20:39:12 volumio volumio[1124]: info: CorePlayQueue::getTrack 0
Feb 26 20:39:12 volumio volumio[1124]: verbose: STATE SERVICE {"status":"play","position":0,"seek":738169,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armored Saint - Last train home","artist":"ROCK ANTENNE Heavy Metal","album":null,"uri":"http://stream.rockantenne.de/heavy-metal/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"}
Feb 26 20:39:12 volumio volumio[1124]: verbose: CURRENT POSITION 0
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::syncState stateService play
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::syncState currentStatus play
Feb 26 20:39:12 volumio volumio[1124]: info: Received an update from plugin. extracting info from payload
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::pushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::volumioPushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::pushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::volumioPushState
Feb 26 20:39:12 volumio volumio[1124]: info: ControllerMpd::pushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::servicePushState
Feb 26 20:39:12 volumio volumio[1124]: info: CorePlayQueue::getTrack 0
Feb 26 20:39:12 volumio volumio[1124]: verbose: STATE SERVICE {"status":"play","position":0,"seek":738169,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armored Saint - Last train home","artist":"ROCK ANTENNE Heavy Metal","album":null,"uri":"http://stream.rockantenne.de/heavy-metal/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"}
Feb 26 20:39:12 volumio volumio[1124]: verbose: CURRENT POSITION 0
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::syncState stateService play
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::syncState currentStatus play
Feb 26 20:39:12 volumio volumio[1124]: info: Received an update from plugin. extracting info from payload
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::pushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::volumioPushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::pushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::volumioPushState
Feb 26 20:39:12 volumio volumio[1124]: info: ControllerMpd::pushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::servicePushState
Feb 26 20:39:12 volumio volumio[1124]: info: CorePlayQueue::getTrack 0
Feb 26 20:39:12 volumio volumio[1124]: verbose: STATE SERVICE {"status":"play","position":0,"seek":738169,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Armored Saint - Last train home","artist":"ROCK ANTENNE Heavy Metal","album":null,"uri":"http://stream.rockantenne.de/heavy-metal/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"}
Feb 26 20:39:12 volumio volumio[1124]: verbose: CURRENT POSITION 0
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::syncState stateService play
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::syncState currentStatus play
Feb 26 20:39:12 volumio volumio[1124]: info: Received an update from plugin. extracting info from payload
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::pushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::volumioPushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreStateMachine::pushState
Feb 26 20:39:12 volumio volumio[1124]: info: CoreCommandRouter::volumioPushState
Feb 26 20:39:12 volumio volumio[1124]: info: ------------------------------ 35ms
Feb 26 20:39:12 volumio volumio[1124]: info: ------------------------------ 34ms
Feb 26 20:39:12 volumio volumio[1124]: info: ------------------------------ 33ms
Feb 26 20:39:12 volumio volumio[1124]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
Feb 26 20:39:12 volumio volumio[1124]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
Feb 26 20:39:12 volumio volumio[1124]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
Feb 26 20:39:12 volumio volumio[1124]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
Feb 26 20:39:12 volumio volumio[1124]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
Feb 26 20:39:12 volumio volumio[1124]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70
Feb 26 20:39:36 volumio volumio[1124]: info: READ
Feb 26 20:39:36 volumio volumio[1124]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 26 20:39:36 volumio volumio[1124]: Error
Feb 26 20:39:36 volumio volumio[1124]: at /volumio/app/plugins/music_service/webradio/index.js:286:31
Feb 26 20:39:36 volumio volumio[1124]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:444:15)
Feb 26 20:39:36 volumio volumio[1124]: at self.callback (/volumio/node_modules/request/request.js:185:22)
Feb 26 20:39:36 volumio volumio[1124]: at Request.emit (node:events:514:28)
Feb 26 20:39:36 volumio volumio[1124]: at Request.onRequestError (/volumio/node_modules/request/request.js:877:8)
Feb 26 20:39:36 volumio volumio[1124]: at ClientRequest.emit (node:events:514:28)
Feb 26 20:39:36 volumio volumio[1124]: at Socket.socketErrorListener (node:_http_client:495:9)
Feb 26 20:39:36 volumio volumio[1124]: at Socket.emit (node:events:514:28)
Feb 26 20:39:36 volumio volumio[1124]: at emitErrorNT (node:internal/streams/destroy:151:8)
Feb 26 20:39:36 volumio volumio[1124]: at emitErrorCloseNT (node:internal/streams/destroy:116:3)
Feb 26 20:39:36 volumio volumio[1124]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 26 20:39:37 volumio sudo[658]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 20:38'
Feb 26 20:39:37 volumio sudo[658]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"