Apr 10 23:56:17 volumio volumio[1108]: info: CorePlayQueue::getTrack 21252
Apr 10 23:56:17 volumio volumio[1108]: info: CorePlayQueue::getTrack 26225
Apr 10 23:56:17 volumio volumio[1108]: info: Prefetching next song
Apr 10 23:56:17 volumio volumio[1108]: info: DOING PREFETCH IN MPD
Apr 10 23:56:17 volumio volumio[1108]: verbose: ControllerMpd::sendMpdCommand add "NAS/ThorMusic/Judas Priest/Sin After Sin (1990)/08- Dissident Aggressor.flac"
Apr 10 23:56:17 volumio volumio[1108]: info:
Apr 10 23:56:17 volumio volumio[1108]: ---------------------------- MPD announces system playlist update
Apr 10 23:56:17 volumio volumio[1108]: info: Ignoring MPD Status Update
Apr 10 23:56:17 volumio volumio[1108]: info: sendMpdCommand add "NAS/ThorMusic/Judas Priest/Sin After Sin (1990)/08- Dissident Aggressor.flac" took 1 milliseconds
Apr 10 23:56:17 volumio volumio[1108]: verbose: ControllerMpd::sendMpdCommand consume 1
Apr 10 23:56:17 volumio volumio[1108]: info: ------------------------------ 1ms
Apr 10 23:56:17 volumio volumio[1108]: info: sendMpdCommand consume 1 took 0 milliseconds
Apr 10 23:56:20 volumio volumio[1108]: info:
Apr 10 23:56:20 volumio volumio[1108]: ---------------------------- MPD announces system playlist update
Apr 10 23:56:20 volumio volumio[1108]: info: Ignoring MPD Status Update
Apr 10 23:56:20 volumio volumio[1108]: info:
Apr 10 23:56:20 volumio volumio[1108]: ---------------------------- MPD announces state update: player
Apr 10 23:56:20 volumio volumio[1108]: info: ControllerMpd::getState
Apr 10 23:56:20 volumio volumio[1108]: verbose: ControllerMpd::sendMpdCommand status
Apr 10 23:56:20 volumio volumio[1108]: info: ------------------------------ 1ms
Apr 10 23:56:20 volumio volumio[1108]: info: sendMpdCommand status took 1 milliseconds
Apr 10 23:56:20 volumio volumio[1108]: verbose: ControllerMpd::parseState
Apr 10 23:56:20 volumio volumio[1108]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 10 23:56:20 volumio volumio[1108]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 10 23:56:20 volumio volumio[1108]: verbose: ControllerMpd::parseTrackInfo
Apr 10 23:56:20 volumio volumio[1108]: info: ControllerMpd::pushState
Apr 10 23:56:20 volumio volumio[1108]: info: CoreCommandRouter::servicePushState
Apr 10 23:56:20 volumio volumio[1108]: info: CorePlayQueue::getTrack 21252
Apr 10 23:56:20 volumio volumio[1108]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":190,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"492 Kbps","isStreaming":false,"title":"Dissident Aggressor","artist":"Judas Priest","album":"Sin After Sin","uri":"NAS/ThorMusic/Judas Priest/Sin After Sin (1990)/08- Dissident Aggressor.flac","trackType":"flac"}
Apr 10 23:56:20 volumio volumio[1108]: verbose: CURRENT POSITION 21252
Apr 10 23:56:20 volumio volumio[1108]: info: CoreStateMachine::syncState stateService play
Apr 10 23:56:20 volumio volumio[1108]: info: CoreStateMachine::syncState currentStatus play
Apr 10 23:56:20 volumio volumio[1108]: info: Received an update from plugin. extracting info from payload
Apr 10 23:56:20 volumio volumio[1108]: info: CoreStateMachine::pushState
Apr 10 23:56:20 volumio volumio[1108]: info: CorePlayQueue::getTrack 21252
Apr 10 23:56:20 volumio volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 10 23:56:20 volumio volumio[1108]: info: CoreCommandRouter::volumioPushState
Apr 10 23:56:20 volumio volumio[1108]: info: CoreStateMachine::pushState
Apr 10 23:56:20 volumio volumio[1108]: info: CorePlayQueue::getTrack 21252
Apr 10 23:56:20 volumio volumio[1108]: info: CoreCommandRouter::volumioPushState
Apr 10 23:56:20 volumio volumio[1108]: info: ------------------------------ 12ms
Apr 10 23:56:20 volumio volumio[1108]: SPOTIFY: RECEIVED VOLUMIO VOLUME 99
Apr 10 23:56:20 volumio volumio[1108]: SPOTIFY: RECEIVED VOLUMIO VOLUME 99
Apr 10 23:56:21 volumio volumio[1108]: info: CoreStateMachine::startPlaybackTimer
Apr 10 23:56:21 volumio volumio[1108]: info: CorePlayQueue::getTrack 26225
Apr 10 23:56:21 volumio volumio[1108]: info: CoreStateMachine::pushState
Apr 10 23:56:21 volumio volumio[1108]: info: CorePlayQueue::getTrack 26225
Apr 10 23:56:21 volumio volumio[1108]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 10 23:56:21 volumio volumio[1108]: info: CoreCommandRouter::volumioPushState
Apr 10 23:56:21 volumio volumio[1108]: info: [LastFM] Current track has sufficient metadata: title (Dissident Aggressor) and artist (Judas Priest) passed on explicitly
Apr 10 23:56:21 volumio volumio[1108]: SPOTIFY: RECEIVED VOLUMIO VOLUME 99
Apr 10 23:56:25 volumio volumio[1108]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 10 23:56:25 volumio volumio[1108]: TypeError: Cannot read properties of null (reading '@')
Apr 10 23:56:25 volumio volumio[1108]: at Object.callback (/data/plugins/user_interface/lastfm/node_modules/simple-lastfm/lib/index.js:342:14)
Apr 10 23:56:25 volumio volumio[1108]: at /data/plugins/user_interface/lastfm/node_modules/simple-lastfm/lib/index.js:60:13
Apr 10 23:56:25 volumio volumio[1108]: at Parser. (/data/plugins/user_interface/lastfm/node_modules/xml2js/lib/parser.js:318:18)
Apr 10 23:56:25 volumio volumio[1108]: at Parser.emit (node:events:514:28)
Apr 10 23:56:25 volumio volumio[1108]: at exports.Parser.Parser.parseString (/data/plugins/user_interface/lastfm/node_modules/xml2js/lib/parser.js:328:16)
Apr 10 23:56:25 volumio volumio[1108]: at Parser.parseString (/data/plugins/user_interface/lastfm/node_modules/xml2js/lib/parser.js:5:59)
Apr 10 23:56:25 volumio volumio[1108]: at IncomingMessage. (/data/plugins/user_interface/lastfm/node_modules/simple-lastfm/lib/index.js:58:14)
Apr 10 23:56:25 volumio volumio[1108]: at IncomingMessage.emit (node:events:526:35)
Apr 10 23:56:25 volumio volumio[1108]: at endReadableNT (node:internal/streams/readable:1376:12)
Apr 10 23:56:25 volumio volumio[1108]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21)
Apr 10 23:56:25 volumio volumio[1108]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 10 23:56:25 volumio sudo[31535]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-10 23:55'
Apr 10 23:56:25 volumio sudo[31535]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"