Mar 29 11:11:07 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState
Mar 29 11:11:07 volumio volumio[1175]: info: Listing playlists
Mar 29 11:11:07 volumio volumio[1175]: info: Listing playlists
Mar 29 11:11:17 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState
Mar 29 11:11:27 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState
Mar 29 11:11:27 volumio volumio[1175]: info: Listing playlists
Mar 29 11:11:27 volumio volumio[1175]: info: Listing playlists
Mar 29 11:11:37 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState
Mar 29 11:11:47 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState
Mar 29 11:11:47 volumio volumio[1175]: info: Listing playlists
Mar 29 11:11:47 volumio volumio[1175]: info: Listing playlists
Mar 29 11:11:52 volumio volumio[1175]: info: CorePlayQueue::getTrack 9
Mar 29 11:11:52 volumio volumio[1175]: info: CorePlayQueue::getTrack 10
Mar 29 11:11:52 volumio volumio[1175]: info: Prefetching next song
Mar 29 11:11:53 volumio volumio[1175]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-164.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D12f10caac065d756bfff990a6a5dba079b07d788111dc967c43b9f7914ecf3af%2Clid%3D40%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69d72de3%2F0%2F486493%2F68ed523d.195989122.16.147122%2Fflac-mp4&ext=.flac"
Mar 29 11:11:53 volumio volumio[1175]: info:
Mar 29 11:11:53 volumio volumio[1175]: ---------------------------- MPD announces system playlist update
Mar 29 11:11:53 volumio volumio[1175]: info: Ignoring MPD Status Update
Mar 29 11:11:53 volumio volumio[1175]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-164.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D12f10caac065d756bfff990a6a5dba079b07d788111dc967c43b9f7914ecf3af%2Clid%3D40%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69d72de3%2F0%2F486493%2F68ed523d.195989122.16.147122%2Fflac-mp4&ext=.flac" took 2 milliseconds
Mar 29 11:11:53 volumio volumio[1175]: verbose: MPD COMMAND [object Object]
Mar 29 11:11:53 volumio volumio[1175]: verbose: MPD COMMAND [object Object]
Mar 29 11:11:53 volumio volumio[1175]: verbose: MPD COMMAND [object Object]
Mar 29 11:11:53 volumio volumio[1175]: info:
Mar 29 11:11:53 volumio volumio[1175]: ---------------------------- MPD announces system playlist update
Mar 29 11:11:53 volumio volumio[1175]: info: Ignoring MPD Status Update
Mar 29 11:11:53 volumio volumio[1175]: info: ------------------------------ 3ms
Mar 29 11:11:53 volumio volumio[1175]: verbose: ControllerMpd::sendMpdCommand consume 1
Mar 29 11:11:53 volumio volumio[1175]: info: ------------------------------ 3ms
Mar 29 11:11:53 volumio volumio[1175]: info: sendMpdCommand consume 1 took 2 milliseconds
Mar 29 11:11:54 volumio volumio[1175]: info: CoreCommandRouter::volumioAddQueueItems
Mar 29 11:11:54 volumio volumio[1175]: info: CoreStateMachine::addQueueItems
Mar 29 11:11:54 volumio volumio[1175]: info: CorePlayQueue::addQueueItems
Mar 29 11:11:54 volumio volumio[1175]: info: Preload queue cleared
Mar 29 11:11:54 volumio volumio[1175]: info: Adding Item to queue: yandex_music/track/45254464:6074872@user:onyourwave
Mar 29 11:11:54 volumio volumio[1175]: info: Exploding uri yandex_music/track/45254464:6074872@user:onyourwave in service yandex_music
Mar 29 11:11:54 volumio volumio[1175]: info: CoreCommandRouter::volumioPushQueue
Mar 29 11:11:54 volumio volumio[1175]: info: CorePlayQueue::saveQueue
Mar 29 11:11:54 volumio volumio[1175]: info: CoreStateMachine::updateTrackBlock
Mar 29 11:11:54 volumio volumio[1175]: info: CorePlayQueue::getTrackBlock
Mar 29 11:11:57 volumio volumio[1175]: info: CoreStateMachine::startPlaybackTimer
Mar 29 11:11:57 volumio volumio[1175]: info: CorePlayQueue::getTrack 10
Mar 29 11:11:57 volumio volumio[1175]: info: CoreStateMachine::pushState
Mar 29 11:11:57 volumio volumio[1175]: info: CorePlayQueue::getTrack 10
Mar 29 11:11:57 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 29 11:11:57 volumio volumio[1175]: info: CoreCommandRouter::volumioPushState
Mar 29 11:11:57 volumio volumio[1175]: info: CoreStateMachine::setConsumeUpdateService mpd
Mar 29 11:11:59 volumio volumio[1175]: info:
Mar 29 11:11:59 volumio volumio[1175]: ---------------------------- MPD announces system playlist update
Mar 29 11:11:59 volumio volumio[1175]: info: Ignoring MPD Status Update
Mar 29 11:11:59 volumio volumio[1175]: info:
Mar 29 11:11:59 volumio volumio[1175]: ---------------------------- MPD announces state update: player
Mar 29 11:11:59 volumio volumio[1175]: info: ControllerMpd::getState
Mar 29 11:11:59 volumio volumio[1175]: verbose: ControllerMpd::sendMpdCommand status
Mar 29 11:11:59 volumio volumio[1175]: info: ------------------------------ 3ms
Mar 29 11:11:59 volumio volumio[1175]: info: sendMpdCommand status took 3 milliseconds
Mar 29 11:11:59 volumio volumio[1175]: verbose: ControllerMpd::parseState
Mar 29 11:11:59 volumio volumio[1175]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 29 11:11:59 volumio volumio[1175]: info: sendMpdCommand playlistinfo took 1 milliseconds
Mar 29 11:11:59 volumio volumio[1175]: verbose: ControllerMpd::parseTrackInfo
Mar 29 11:11:59 volumio volumio[1175]: info: ControllerMpd::pushState
Mar 29 11:11:59 volumio volumio[1175]: info: CoreCommandRouter::servicePushState
Mar 29 11:11:59 volumio volumio[1175]: info: CorePlayQueue::getTrack 10
Mar 29 11:11:59 volumio volumio[1175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Live Forever","artist":"Magnus Carlsson","album":"Live Forever - The Album","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-164.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D12f10caac065d756bfff990a6a5dba079b07d788111dc967c43b9f7914ecf3af%2Clid%3D40%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69d72de3%2F0%2F486493%2F68ed523d.195989122.16.147122%2Fflac-mp4&ext=.flac","trackType":"flac"}
Mar 29 11:11:59 volumio volumio[1175]: verbose: CURRENT POSITION 10
Mar 29 11:11:59 volumio volumio[1175]: info: CoreStateMachine::syncState stateService play
Mar 29 11:11:59 volumio volumio[1175]: info: CoreStateMachine::syncState currentStatus play
Mar 29 11:11:59 volumio volumio[1175]: info: Received an update from plugin. extracting info from payload
Mar 29 11:11:59 volumio volumio[1175]: info: CoreStateMachine::pushState
Mar 29 11:11:59 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 29 11:11:59 volumio volumio[1175]: info: CoreCommandRouter::volumioPushState
Mar 29 11:11:59 volumio volumio[1175]: info: CoreStateMachine::pushState
Mar 29 11:11:59 volumio volumio[1175]: info: CoreCommandRouter::volumioPushState
Mar 29 11:11:59 volumio volumio[1175]: info: ------------------------------ 16ms
Mar 29 11:12:00 volumio volumio[1175]: info:
Mar 29 11:12:00 volumio volumio[1175]: ---------------------------- MPD announces state update: player
Mar 29 11:12:00 volumio volumio[1175]: info: ControllerMpd::getState
Mar 29 11:12:00 volumio volumio[1175]: verbose: ControllerMpd::sendMpdCommand status
Mar 29 11:12:00 volumio volumio[1175]: info:
Mar 29 11:12:00 volumio volumio[1175]: ---------------------------- MPD announces state update: player
Mar 29 11:12:00 volumio volumio[1175]: info: sendMpdCommand status took 200 milliseconds
Mar 29 11:12:00 volumio volumio[1175]: info: ControllerMpd::getState
Mar 29 11:12:00 volumio volumio[1175]: verbose: ControllerMpd::sendMpdCommand status
Mar 29 11:12:00 volumio volumio[1175]: verbose: ControllerMpd::parseState
Mar 29 11:12:00 volumio volumio[1175]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 29 11:12:00 volumio volumio[1175]: info: sendMpdCommand status took 3 milliseconds
Mar 29 11:12:00 volumio volumio[1175]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 29 11:12:00 volumio volumio[1175]: verbose: ControllerMpd::parseState
Mar 29 11:12:00 volumio volumio[1175]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 29 11:12:00 volumio volumio[1175]: verbose: ControllerMpd::parseTrackInfo
Mar 29 11:12:00 volumio volumio[1175]: info: ControllerMpd::pushState
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::servicePushState
Mar 29 11:12:00 volumio volumio[1175]: info: CorePlayQueue::getTrack 10
Mar 29 11:12:00 volumio volumio[1175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1088 Kbps","isStreaming":false,"title":"Live Forever","artist":"Magnus Carlsson","album":"Live Forever - The Album","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-164.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D12f10caac065d756bfff990a6a5dba079b07d788111dc967c43b9f7914ecf3af%2Clid%3D40%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69d72de3%2F0%2F486493%2F68ed523d.195989122.16.147122%2Fflac-mp4&ext=.flac","trackType":"flac"}
Mar 29 11:12:00 volumio volumio[1175]: verbose: CURRENT POSITION 10
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::syncState stateService play
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::syncState currentStatus play
Mar 29 11:12:00 volumio volumio[1175]: info: Received an update from plugin. extracting info from payload
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::pushState
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::volumioPushState
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::pushState
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::volumioPushState
Mar 29 11:12:00 volumio volumio[1175]: info: ------------------------------ 217ms
Mar 29 11:12:00 volumio volumio[1175]: info: sendMpdCommand playlistinfo took 15 milliseconds
Mar 29 11:12:00 volumio volumio[1175]: verbose: ControllerMpd::parseTrackInfo
Mar 29 11:12:00 volumio volumio[1175]: info: ControllerMpd::pushState
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::servicePushState
Mar 29 11:12:00 volumio volumio[1175]: info: CorePlayQueue::getTrack 10
Mar 29 11:12:00 volumio volumio[1175]: verbose: STATE SERVICE {"status":"play","position":0,"seek":573,"duration":183,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1088 Kbps","isStreaming":false,"title":"Live Forever","artist":"Magnus Carlsson","album":"Live Forever - The Album","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-164.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D12f10caac065d756bfff990a6a5dba079b07d788111dc967c43b9f7914ecf3af%2Clid%3D40%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69d72de3%2F0%2F486493%2F68ed523d.195989122.16.147122%2Fflac-mp4&ext=.flac","trackType":"flac"}
Mar 29 11:12:00 volumio volumio[1175]: verbose: CURRENT POSITION 10
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::syncState stateService play
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::syncState currentStatus play
Mar 29 11:12:00 volumio volumio[1175]: info: Received an update from plugin. extracting info from payload
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::pushState
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::volumioPushState
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::pushState
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::volumioPushState
Mar 29 11:12:00 volumio volumio[1175]: info: ------------------------------ 31ms
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::volumioGetQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::getQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CorePlayQueue::getQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::volumioGetQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::getQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CorePlayQueue::getQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::volumioGetQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::getQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CorePlayQueue::getQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CoreCommandRouter::volumioGetQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CoreStateMachine::getQueue
Mar 29 11:12:00 volumio volumio[1175]: info: CorePlayQueue::getQueue
Mar 29 11:12:02 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState
Mar 29 11:12:08 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState
Mar 29 11:12:08 volumio volumio[1175]: info: Listing playlists
Mar 29 11:12:08 volumio volumio[1175]: info: Listing playlists
Mar 29 11:12:19 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState
Mar 29 11:12:19 volumio volumio5-onboarding[1572]: time=2026-03-29T11:12:19.307+03:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.107:50979
Mar 29 11:12:20 volumio volumio[1175]: verbose: New Socket.io Connection to 192.168.1.45 from 192.168.1.107 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6
Mar 29 11:12:20 volumio bluealsa[913]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_56_FF_8E_BF_03_75, ...)
Mar 29 11:12:23 volumio volumio[1175]: verbose: New Socket.io Connection to 192.168.1.45 from 192.168.1.107 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7
Mar 29 11:12:24 volumio volumio5-onboarding[1572]: time=2026-03-29T11:12:24.444+03:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.107:50979
Mar 29 11:12:24 volumio volumio5-onboarding[1572]: time=2026-03-29T11:12:24.444+03:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.107:50979
Mar 29 11:12:24 volumio volumio[1175]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 29 11:12:24 volumio volumio[1175]: Error: read ECONNRESET
Mar 29 11:12:24 volumio volumio[1175]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:217:20) {
Mar 29 11:12:24 volumio volumio[1175]: errno: -104,
Mar 29 11:12:24 volumio volumio[1175]: code: 'ECONNRESET',
Mar 29 11:12:24 volumio volumio[1175]: syscall: 'read'
Mar 29 11:12:24 volumio volumio[1175]: }
Mar 29 11:12:24 volumio volumio[1175]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 29 11:12:24 volumio volumio[1175]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 29 11:12:24 volumio volumio5-onboarding[1572]: time=2026-03-29T11:12:24.702+03:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.107:50983
Mar 29 11:12:25 volumio sudo[20383]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-29 11:11'
Mar 29 11:12:25 volumio sudo[20383]: 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"