Feb 24 19:05:43 raspi2 systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories... Feb 24 19:05:43 raspi2 systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully. Feb 24 19:05:43 raspi2 systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories. Feb 24 19:05:43 raspi2 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully. Feb 24 19:06:38 raspi2 thd[670]: Executing trigger action: volumio toggle Feb 24 19:06:38 raspi2 thd[670]: Executing trigger action: volumio toggle Feb 24 19:06:38 raspi2 dbus-daemon[655]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.44' (uid=1000 pid=3935 comm="hostnamectl") Feb 24 19:06:38 raspi2 thd[3936]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 24 19:06:38 raspi2 thd[3936]: Dload Upload Total Spent Left Speed Feb 24 19:06:38 raspi2 thd[3936]: [79B blob data] Feb 24 19:06:38 raspi2 thd[3937]: % Total % Received % Xferd Average Speed Time Time Time Current Feb 24 19:06:38 raspi2 thd[3937]: Dload Upload Total Spent Left Speed Feb 24 19:06:38 raspi2 volumio[2770]: info: Feb 24 19:06:38 raspi2 volumio[2770]: ---------------------------- Client requests Volumio toggle Feb 24 19:06:38 raspi2 volumio[2770]: info: CoreCommandRouter::volumioToggle Feb 24 19:06:38 raspi2 volumio[2770]: info: CorePlayQueue::getTrack 0 Feb 24 19:06:38 raspi2 volumio[2770]: info: CoreStateMachine::play index undefined Feb 24 19:06:38 raspi2 volumio[2770]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 19:06:38 raspi2 volumio[2770]: info: CorePlayQueue::getTrack 0 Feb 24 19:06:38 raspi2 volumio[2770]: info: CoreStateMachine::startPlaybackTimer Feb 24 19:06:38 raspi2 volumio[2770]: info: CorePlayQueue::getTrack 0 Feb 24 19:06:38 raspi2 volumio[2770]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/admin@84ed3b41aa974799902e0fb151c2db45/song@songId=46b8884dadb4d812d3df764ff1e8dca2 Feb 24 19:06:38 raspi2 volumio[2770]: info: [jellyfin-conn] Using previously assigned device Id for admin@raspi5: 45eb01e7-09ab-45f4-9975-4e57a20dc431 Feb 24 19:06:38 raspi2 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Feb 24 19:06:38 raspi2 thd[3937]: [79B blob data] Feb 24 19:06:38 raspi2 thd[3936]: [79B blob data] Feb 24 19:06:38 raspi2 volumio[2770]: info: Feb 24 19:06:38 raspi2 volumio[2770]: ---------------------------- Client requests Volumio toggle Feb 24 19:06:38 raspi2 volumio[2770]: info: CoreCommandRouter::volumioToggle Feb 24 19:06:38 raspi2 volumio[2770]: info: CorePlayQueue::getTrack 0 Feb 24 19:06:38 raspi2 volumio[2770]: info: CoreStateMachine::play index undefined Feb 24 19:06:38 raspi2 volumio[2770]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 24 19:06:38 raspi2 volumio[2770]: info: CorePlayQueue::getTrack 0 Feb 24 19:06:38 raspi2 volumio[2770]: info: CoreStateMachine::startPlaybackTimer Feb 24 19:06:38 raspi2 volumio[2770]: info: CorePlayQueue::getTrack 0 Feb 24 19:06:38 raspi2 volumio[2770]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/admin@84ed3b41aa974799902e0fb151c2db45/song@songId=46b8884dadb4d812d3df764ff1e8dca2 Feb 24 19:06:38 raspi2 volumio[2770]: info: [jellyfin-conn] Returning existing auth promise Feb 24 19:06:38 raspi2 thd[3936]: {"time":1771981598772,"response":"toggle Success"} Feb 24 19:06:38 raspi2 thd[3937]: [79B blob data] Feb 24 19:06:39 raspi2 volumio[2770]: info: [jellyfin-conn] Login successful: admin@raspi5 Feb 24 19:06:39 raspi2 volumio[2770]: info: [jellyfin-play] Stream URL for Llama Por Favor: http://100.93.223.101:8096/Audio/46b8884dadb4d812d3df764ff1e8dca2/stream.flac?static=true&mediaSourceId=46b8884dadb4d812d3df764ff1e8dca2&tag=e9dfcc18cbb5e38dcc5b08262560d0cb Feb 24 19:06:39 raspi2 volumio[2770]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 19:06:39 raspi2 volumio[2770]: info: sendMpdCommand stop took 7 milliseconds Feb 24 19:06:39 raspi2 volumio[2770]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 19:06:39 raspi2 volumio[2770]: info: sendMpdCommand clear took 2 milliseconds Feb 24 19:06:39 raspi2 volumio[2770]: verbose: ControllerMpd::sendMpdCommand load "http://100.93.223.101:8096/Audio/46b8884dadb4d812d3df764ff1e8dca2/stream.flac?static=true&mediaSourceId=46b8884dadb4d812d3df764ff1e8dca2&tag=e9dfcc18cbb5e38dcc5b08262560d0cb&t.flac" Feb 24 19:06:39 raspi2 volumio[2770]: info: Feb 24 19:06:39 raspi2 volumio[2770]: ---------------------------- MPD announces system playlist update Feb 24 19:06:39 raspi2 volumio[2770]: info: Ignoring MPD Status Update Feb 24 19:06:39 raspi2 volumio[2770]: info: [jellyfin-play] Stream URL for Llama Por Favor: http://100.93.223.101:8096/Audio/46b8884dadb4d812d3df764ff1e8dca2/stream.flac?static=true&mediaSourceId=46b8884dadb4d812d3df764ff1e8dca2&tag=e9dfcc18cbb5e38dcc5b08262560d0cb Feb 24 19:06:39 raspi2 volumio[2770]: verbose: ControllerMpd::sendMpdCommand stop Feb 24 19:06:39 raspi2 volumio[2770]: info: Feb 24 19:06:39 raspi2 volumio[2770]: ---------------------------- MPD announces system playlist update Feb 24 19:06:39 raspi2 volumio[2770]: info: Ignoring MPD Status Update Feb 24 19:06:39 raspi2 volumio[2770]: info: Feb 24 19:06:39 raspi2 volumio[2770]: ---------------------------- MPD announces system playlist update Feb 24 19:06:39 raspi2 volumio[2770]: info: Ignoring MPD Status Update Feb 24 19:06:39 raspi2 upmpdcli[1518]: :3:../src/mpdcli.cxx:148::MPDCli::startEventLoop: already started Feb 24 19:06:39 raspi2 volumio[2770]: error: updateQueue error: null Feb 24 19:06:39 raspi2 volumio[2770]: error: updateQueue error: null Feb 24 19:06:39 raspi2 volumio[2770]: error: updateQueue error: null Feb 24 19:06:39 raspi2 volumio[2770]: verbose: ControllerMpd::sendMpdCommand addid "http://100.93.223.101:8096/Audio/46b8884dadb4d812d3df764ff1e8dca2/stream.flac?static=true&mediaSourceId=46b8884dadb4d812d3df764ff1e8dca2&tag=e9dfcc18cbb5e38dcc5b08262560d0cb&t.flac" Feb 24 19:06:39 raspi2 volumio[2770]: info: ------------------------------ 123ms Feb 24 19:06:39 raspi2 volumio[2770]: info: sendMpdCommand stop took 113 milliseconds Feb 24 19:06:39 raspi2 volumio[2770]: info: ------------------------------ 111ms Feb 24 19:06:39 raspi2 volumio[2770]: info: ------------------------------ 105ms Feb 24 19:06:39 raspi2 volumio[2770]: verbose: ControllerMpd::sendMpdCommand clear Feb 24 19:06:39 raspi2 volumio[2770]: info: Feb 24 19:06:39 raspi2 volumio[2770]: ---------------------------- MPD announces system playlist update Feb 24 19:06:39 raspi2 volumio[2770]: info: Ignoring MPD Status Update Feb 24 19:06:39 raspi2 volumio[2770]: info: Feb 24 19:06:39 raspi2 volumio[2770]: ---------------------------- MPD announces system playlist update Feb 24 19:06:39 raspi2 volumio[2770]: info: Ignoring MPD Status Update Feb 24 19:06:39 raspi2 volumio[2770]: info: sendMpdCommand addid "http://100.93.223.101:8096/Audio/46b8884dadb4d812d3df764ff1e8dca2/stream.flac?static=true&mediaSourceId=46b8884dadb4d812d3df764ff1e8dca2&tag=e9dfcc18cbb5e38dcc5b08262560d0cb&t.flac" took 15 milliseconds Feb 24 19:06:39 raspi2 volumio[2770]: info: sendMpdCommand clear took 9 milliseconds Feb 24 19:06:39 raspi2 volumio[2770]: verbose: ControllerMpd::sendMpdCommand load "http://100.93.223.101:8096/Audio/46b8884dadb4d812d3df764ff1e8dca2/stream.flac?static=true&mediaSourceId=46b8884dadb4d812d3df764ff1e8dca2&tag=e9dfcc18cbb5e38dcc5b08262560d0cb&t.flac" Feb 24 19:06:39 raspi2 volumio[2770]: verbose: MPD COMMAND [object Object] Feb 24 19:06:39 raspi2 volumio[2770]: verbose: MPD COMMAND [object Object] Feb 24 19:06:39 raspi2 volumio[2770]: verbose: MPD COMMAND [object Object] Feb 24 19:06:39 raspi2 volumio[2770]: info: Feb 24 19:06:39 raspi2 volumio[2770]: ---------------------------- MPD announces system playlist update Feb 24 19:06:39 raspi2 volumio[2770]: info: Ignoring MPD Status Update Feb 24 19:06:39 raspi2 volumio[2770]: info: Feb 24 19:06:39 raspi2 volumio[2770]: ---------------------------- MPD announces system playlist update Feb 24 19:06:39 raspi2 volumio[2770]: info: Ignoring MPD Status Update Feb 24 19:06:39 raspi2 volumio[2770]: error: updateQueue error: null Feb 24 19:06:39 raspi2 volumio[2770]: error: updateQueue error: null Feb 24 19:06:39 raspi2 volumio[2770]: info: ------------------------------ 44ms Feb 24 19:06:39 raspi2 volumio[2770]: info: ------------------------------ 45ms Feb 24 19:06:39 raspi2 volumio[2770]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 19:06:39 raspi2 volumio[2770]: Error: [50@0] {addtagid} No such song Feb 24 19:06:39 raspi2 volumio[2770]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:17) Feb 24 19:06:39 raspi2 volumio[2770]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Feb 24 19:06:39 raspi2 volumio[2770]: at Socket.emit (node:events:514:28) Feb 24 19:06:39 raspi2 volumio[2770]: at addChunk (node:internal/streams/readable:343:12) Feb 24 19:06:39 raspi2 volumio[2770]: at readableAddChunk (node:internal/streams/readable:312:11) Feb 24 19:06:39 raspi2 volumio[2770]: at Readable.push (node:internal/streams/readable:253:10) Feb 24 19:06:39 raspi2 volumio[2770]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Feb 24 19:06:39 raspi2 volumio[2770]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 19:06:39 raspi2 dbus-daemon[655]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 24 19:06:39 raspi2 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Feb 24 19:06:41 raspi2 sudo[3956]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-24 19:05' Feb 24 19:06:41 raspi2 sudo[3956]: 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"