-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Mon 2026-10-12 10:35:13 CEST. -- Oct 12 10:34:00 zolder volumio5-onboarding[1328]: time=2026-10-12T10:34:00.123+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Oct 12 10:34:00 zolder volumio5-onboarding[1328]: time=2026-10-12T10:34:00.124+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Oct 12 10:34:00 zolder volumio5-onboarding[1328]: time=2026-10-12T10:34:00.124+02:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Oct 12 10:34:00 zolder volumio5-onboarding[1328]: time=2026-10-12T10:34:00.124+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Oct 12 10:34:00 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 10:34:00 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 10:34:00 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 10:34:00 zolder volumio[952]: error: MyVolumio Plugin failed to authenticate in a timely fashion Oct 12 10:34:00 zolder volumio[952]: info: Completed starting MyVolumio Plugin Oct 12 10:34:00 zolder volumio[952]: [Metrics] CommandRouter: 44s 917.79ms Oct 12 10:34:00 zolder volumio[952]: info: CoreCommandRouter::volumiosetStartupVolume Oct 12 10:34:00 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 10:34:00 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 10:34:00 zolder volumio[952]: info: CoreCommandRouter::Close All Modals sent Oct 12 10:34:00 zolder volumio[952]: info: CoreCommandRouter::Close All Modals sent Oct 12 10:34:00 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:00 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:00 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:00 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:00 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:01 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 10:34:01 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 12 10:34:01 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 12 10:34:01 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 12 10:34:01 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 12 10:34:02 zolder volumio5-onboarding[1328]: time=2026-10-12T10:34:02.217+02:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=kSJpvNAtUaTt2wPkNbk2G1vOwpG2 tokenExpiry=2026-10-12T11:34:02.217+02:00 Oct 12 10:34:03 zolder volumio[952]: info: Received Get System Info Oct 12 10:34:03 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 10:34:03 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 10:34:03 zolder volumio[952]: info: Discovery: Getting this device information Oct 12 10:34:03 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:34:03 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:34:03 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 10:34:03 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 12 10:34:03 zolder volumio5-onboarding[1328]: time=2026-10-12T10:34:03.569+02:00 level=INFO msg="enabling local network discovery" Oct 12 10:34:03 zolder volumio5-onboarding[1328]: time=2026-10-12T10:34:03.586+02:00 level=INFO msg="enabling BLE discovery" Oct 12 10:34:05 zolder volumio5-onboarding[1328]: time=2026-10-12T10:34:05.348+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 12 10:34:05 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:05 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:05 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:05 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:05 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:06 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:34:06 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:34:06 zolder volumio[952]: info: Listing playlists Oct 12 10:34:06 zolder volumio[952]: info: Listing playlists Oct 12 10:34:06 zolder volumio[952]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 12 10:34:07 zolder volumio[952]: info: BOOT COMPLETED Oct 12 10:34:10 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:10 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:10 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:10 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:10 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:15 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:15 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:15 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:15 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:15 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:16 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:34:16 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:34:20 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:20 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:20 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:20 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:20 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:25 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:25 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:25 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:25 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:25 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:26 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:34:26 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:34:26 zolder volumio[952]: info: Listing playlists Oct 12 10:34:26 zolder volumio[952]: info: Listing playlists Oct 12 10:34:30 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:30 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:30 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:30 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:30 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:35 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:35 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:35 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:35 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:35 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:36 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:34:36 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:34:40 zolder volumio[952]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 12 10:34:40 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:40 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:40 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:40 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:40 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:45 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:45 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:45 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:45 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:45 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:46 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:34:46 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:34:46 zolder volumio[952]: info: Listing playlists Oct 12 10:34:46 zolder volumio[952]: info: Listing playlists Oct 12 10:34:50 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:50 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:50 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:50 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:50 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:55 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:34:55 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:34:55 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:34:55 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:34:55 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:34:56 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:34:56 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:35:00 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:35:00 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:35:00 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:35:00 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:35:00 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:35:02 zolder volumio[952]: verbose: New Socket.io Connection to 192.168.5.3 from 192.168.1.217 UA: Mozilla/5.0 (X11; Linux x86_64; rv:157.0) Gecko/20100101 Firefox/157.0 Engine version: 3 Transport: polling Total Clients: 5 Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::volumioGetVisibleSources Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:35:02 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::volumioGetQueue Oct 12 10:35:02 zolder volumio[952]: info: CoreStateMachine::getQueue Oct 12 10:35:02 zolder volumio[952]: info: CorePlayQueue::getQueue Oct 12 10:35:02 zolder volumio[952]: info: Listing playlists Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 12 10:35:02 zolder volumio[952]: info: Received Get System Info Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 10:35:02 zolder volumio[952]: info: Discovery: Getting this device information Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:35:02 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:35:02 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 12 10:35:02 zolder volumio[952]: error: Cannot get UI Settings Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 12 10:35:02 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 12 10:35:05 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 10:35:05 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:35:05 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:35:05 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:35:05 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:35:05 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:35:06 zolder volumio[952]: info: Received Get System Info Oct 12 10:35:06 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 10:35:06 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 10:35:06 zolder volumio[952]: info: Discovery: Getting this device information Oct 12 10:35:06 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:35:06 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:35:06 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 10:35:06 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:35:06 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:35:06 zolder volumio[952]: info: Listing playlists Oct 12 10:35:06 zolder volumio[952]: info: Listing playlists Oct 12 10:35:07 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 10:35:08 zolder volumio[952]: info: Received Get System Info Oct 12 10:35:08 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 10:35:08 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 10:35:08 zolder volumio[952]: info: Discovery: Getting this device information Oct 12 10:35:08 zolder volumio[952]: info: CoreCommandRouter::volumioGetState Oct 12 10:35:08 zolder volumio[952]: info: CorePlayQueue::getTrack 0 Oct 12 10:35:08 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 10:35:10 zolder volumio[952]: error: [ytcr] Error connecting MPD: Oct 12 10:35:10 zolder volumio[952]: (Error) connect ENOENT /run/mpd/socket Oct 12 10:35:10 zolder volumio[952]: Error: connect ENOENT /run/mpd/socket Oct 12 10:35:10 zolder volumio[952]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Oct 12 10:35:10 zolder volumio[952]: Retrying in 5 seconds... Oct 12 10:35:12 zolder volumio[952]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 12 10:35:12 zolder volumio[952]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 10:35:12 zolder volumio[952]: TypeError: Cannot read property 'then' of undefined Oct 12 10:35:12 zolder volumio[952]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:2027:20) Oct 12 10:35:12 zolder volumio[952]: at Socket.emit (events.js:315:20) Oct 12 10:35:12 zolder volumio[952]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 12 10:35:12 zolder volumio[952]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 12 10:35:12 zolder volumio[952]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 10:35:13 zolder sudo[1520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-12 10:34 Oct 12 10:35:13 zolder sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="5c0e72e4b5817fe66c91c9d15d75ff13b8e3f4ba" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 30 Mar 2026 02:51:29 PM CEST" VOLUMIO_VERSION="3.914" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="98fe12c88d8ff391f569279e2f874892"