-- Logs begin at Mon 2025-06-23 23:06:47 UTC, end at Sat 2025-10-25 11:19:27 UTC. -- Oct 25 11:19:09 volumio-shd systemd[1]: Time has been changed Oct 25 11:19:11 volumio-shd volumio[797]: info: Loading plugin "updater_comm"... Oct 25 11:19:11 volumio-shd volumio[797]: info: Plugin mpdemulation is not enabled Oct 25 11:19:11 volumio-shd volumio[797]: info: Loading plugin "rest_api"... Oct 25 11:19:11 volumio-shd volumio[797]: info: Loading plugin "websocket"... Oct 25 11:19:11 volumio-shd volumio[797]: info: Plugin Systeminfo is not enabled Oct 25 11:19:11 volumio-shd volumio[797]: info: Loading plugin "squeezelite"... Oct 25 11:19:12 volumio-shd volumio[797]: info: [Squeezelite] Initiated plugin Oct 25 11:19:12 volumio-shd volumio[797]: info: ___________ START PLUGINS ___________ Oct 25 11:19:12 volumio-shd volumio[797]: info: Adding METAVOLUMIO REST API Endpoints Oct 25 11:19:12 volumio-shd volumio[797]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 25 11:19:12 volumio-shd volumio[797]: info: [1761391152436] CoreMusicLibrary::Adding element Last_100 Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 25 11:19:12 volumio-shd volumio[797]: info: Streaming services startup Oct 25 11:19:12 volumio-shd volumio[797]: info: Starting Streaming Daemon Oct 25 11:19:12 volumio-shd sudo[931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 25 11:19:12 volumio-shd sudo[931]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 11:19:12 volumio-shd systemd[1]: Stopping Volumio Streaming Daemon... Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 25 11:19:12 volumio-shd volumio[797]: info: [1761391152545] CoreMusicLibrary::Adding element Webradio Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 25 11:19:12 volumio-shd systemd[1]: Starting Volumio Streaming Daemon... Oct 25 11:19:12 volumio-shd systemd[1]: Started Volumio Streaming Daemon. Oct 25 11:19:12 volumio-shd sudo[931]: pam_unix(sudo:session): session closed for user root Oct 25 11:19:12 volumio-shd volumio[797]: error: Hi Res Audio Failed Login: Missing Login Data Oct 25 11:19:12 volumio-shd volumio-streaming-daemon[938]: ############################ Oct 25 11:19:12 volumio-shd volumio-streaming-daemon[938]: # Volumio Streaming Daemon # Oct 25 11:19:12 volumio-shd volumio-streaming-daemon[938]: # Running on port 7777 # Oct 25 11:19:12 volumio-shd volumio-streaming-daemon[938]: ############################ Oct 25 11:19:12 volumio-shd volumio-streaming-daemon[938]: Checking variant in static cache Oct 25 11:19:12 volumio-shd volumio-streaming-daemon[938]: Enabled services: Oct 25 11:19:12 volumio-shd volumio-streaming-daemon[938]: 1) tidal Oct 25 11:19:12 volumio-shd volumio-streaming-daemon[938]: 2) qobuz Oct 25 11:19:12 volumio-shd sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 25 11:19:12 volumio-shd sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 11:19:12 volumio-shd volumio[797]: info: Loading i18n strings for locale en Oct 25 11:19:12 volumio-shd systemd[1]: Reloading. Oct 25 11:19:12 volumio-shd volumio[797]: Updating browse sources language Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::initPlayerControls Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 25 11:19:12 volumio-shd systemd[1]: [/lib/systemd/system/volumio-remote-updater-push.service:6] Failed to parse usec_t value, ignoring: infinity Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 25 11:19:12 volumio-shd volumio[797]: info: BOOT COMPLETED Oct 25 11:19:12 volumio-shd volumio[797]: [Metrics] CommandRouter: 16s 197.26ms Oct 25 11:19:12 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 11:19:13 volumio-shd sudo[945]: pam_unix(sudo:session): session closed for user root Oct 25 11:19:14 volumio-shd volumio-remote-updater[627]: [2025-10-25 11:19:14] [connect] Successful connection Oct 25 11:19:18 volumio-shd volumio[797]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 25 11:19:18 volumio-shd volumio[797]: info: CoreCommandRouter::Close All Modals sent Oct 25 11:19:18 volumio-shd volumio[797]: info: CoreCommandRouter::Close All Modals sent Oct 25 11:19:18 volumio-shd volumio[797]: Express server listening on port 3000 Oct 25 11:19:18 volumio-shd volumio[797]: [Metrics] WebUI: 22s 961.01ms Oct 25 11:19:18 volumio-shd volumio[797]: Volumio Calling Home Oct 25 11:19:18 volumio-shd volumio[797]: info: CoreStateMachine::resetVolumioState Oct 25 11:19:18 volumio-shd volumio[797]: info: CoreStateMachine::getcurrentVolume Oct 25 11:19:18 volumio-shd volumio[797]: info: CoreCommandRouter::volumioRetrievevolume Oct 25 11:19:18 volumio-shd volumio[797]: info: Stopping AccessToken refresher cron for QOBUZ Oct 25 11:19:18 volumio-shd volumio[797]: info: AccessToken refresher cron started for QOBUZ Oct 25 11:19:18 volumio-shd volumio[797]: info: Stopping AccessToken refresher cron Oct 25 11:19:18 volumio-shd volumio[797]: info: AccessToken refresher cron started Oct 25 11:19:18 volumio-shd volumio[797]: info: CoreStateMachine::pushState Oct 25 11:19:18 volumio-shd volumio[797]: info: CorePlayQueue::getTrack 0 Oct 25 11:19:18 volumio-shd volumio[797]: info: CoreCommandRouter::volumioPushState Oct 25 11:19:18 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 11:19:21 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 11:19:21 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 25 11:19:21 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 11:19:21 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 25 11:19:21 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 25 11:19:21 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 25 11:19:21 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 25 11:19:21 volumio-shd volumio[797]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 25 11:19:21 volumio-shd volumio[797]: info: Cannot read play queue from file Oct 25 11:19:21 volumio-shd volumio[797]: info: Serial port opened successfully Oct 25 11:19:21 volumio-shd volumio[797]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Hardware Oct 25 11:19:21 volumio-shd volumio[797]: info: squeezelite reloaded Oct 25 11:19:21 volumio-shd volumio[797]: info: [Squeezelite] Read MAC address - 0e:00:13:e3:d0:56 Oct 25 11:19:21 volumio-shd sudo[971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart squeezelite Oct 25 11:19:21 volumio-shd sudo[971]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 11:19:21 volumio-shd volumio[797]: error: Cannot initialize MPD Connection: MPD is not running Oct 25 11:19:21 volumio-shd sudo[973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Oct 25 11:19:21 volumio-shd sudo[973]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 25 11:19:21 volumio-shd sudo[973]: pam_unix(sudo:session): session closed for user root Oct 25 11:19:21 volumio-shd volumio[797]: info: Volumio called home Oct 25 11:19:24 volumio-shd systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Oct 25 11:19:24 volumio-shd systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioStop Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::stop Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 11:19:25 volumio-shd volumio[797]: verbose: UNSET VOLATILE Oct 25 11:19:25 volumio-shd volumio[797]: info: Notifying Active Input {"status":"play","service":"inputs","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"","seek":0,"duration":0,"samplerate":"","bitdepth":"","stream":"","disableUiControls":false,"channels":2,"dirac":""} Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 25 11:19:25 volumio-shd volumio[797]: [28B blob data] Oct 25 11:19:25 volumio-shd volumio[797]: PUSH MODEL 1 Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat Oct 25 11:19:25 volumio-shd volumio[797]: error: Could not retrieve plugin music_service raat Oct 25 11:19:25 volumio-shd volumio[797]: info: Adding MINIDSP Inputs Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 25 11:19:25 volumio-shd volumio[797]: info: [1761391165169] CoreMusicLibrary::Adding element Inputs Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 25 11:19:25 volumio-shd volumio[797]: info: [1761391165195] CoreMusicLibrary::Adding element Presets Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::servicePushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::pushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioPushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 11:19:25 volumio-shd sudo[971]: pam_unix(sudo:session): session closed for user root Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::setRepeat null single undefined Oct 25 11:19:25 volumio-shd volumio[797]: info: WARNING: No repeat method for plugin inputs Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::setRandom null Oct 25 11:19:25 volumio-shd volumio[797]: info: WARNING: No random method for plugin inputs Oct 25 11:19:25 volumio-shd volumio[797]: [27B blob data] Oct 25 11:19:25 volumio-shd volumio[797]: PUSH MUTE FALSE Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::pushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioPushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Oct 25 11:19:25 volumio-shd volumio[797]: error: Could not retrieve plugin music_service raat Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::servicePushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::pushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioPushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 11:19:25 volumio-shd volumio[797]: info: [inputs] - Error getting samplerate Oct 25 11:19:25 volumio-shd volumio[797]: info: [inputs] - Error getting bitdepth Oct 25 11:19:25 volumio-shd volumio[797]: info: squeezelite started Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::servicePushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::pushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioPushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 11:19:25 volumio-shd volumio[797]: [29B blob data] Oct 25 11:19:25 volumio-shd volumio[797]: PUSH SOURCE 7 Oct 25 11:19:25 volumio-shd volumio[797]: GET DSP Oct 25 11:19:25 volumio-shd volumio[797]: PUSH DSP 1111111 Oct 25 11:19:25 volumio-shd volumio[797]: GET PRESET Oct 25 11:19:25 volumio-shd volumio[797]: PUSH PRESET 4 Oct 25 11:19:25 volumio-shd volumio[797]: GET MVOL Oct 25 11:19:25 volumio-shd volumio[797]: PUSH MVOL Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: minidspshd-input-defaults , setDefaultValues Oct 25 11:19:25 volumio-shd volumio[797]: error: Could not retrieve plugin audio_interface minidspshd-input-defaults Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumiosetSourceActiveno-source Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: raat , updateDSP Oct 25 11:19:25 volumio-shd volumio[797]: error: Could not retrieve plugin music_service raat Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::pushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioPushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Oct 25 11:19:25 volumio-shd volumio[797]: error: Could not retrieve plugin music_service raat Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::servicePushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreStateMachine::pushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioPushState Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 11:19:25 volumio-shd volumio[797]: info: CoreCommandRouter::volumioGetState Oct 25 11:19:25 volumio-shd volumio[797]: info: mDNS: A device disapperared from network Oct 25 11:19:25 volumio-shd volumio[797]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Oct 25 11:19:25 volumio-shd volumio[797]: info: [inputs] - Error getting samplerate Oct 25 11:19:25 volumio-shd volumio[797]: info: [inputs] - Error getting bitdepth Oct 25 11:19:25 volumio-shd volumio[797]: info: [inputs] - Error getting samplerate Oct 25 11:19:25 volumio-shd volumio[797]: info: [inputs] - Error getting bitdepth Oct 25 11:19:26 volumio-shd volumio[797]: info: [inputs] - Error getting samplerate Oct 25 11:19:26 volumio-shd volumio[797]: info: [inputs] - Error getting bitdepth Oct 25 11:19:26 volumio-shd volumio[797]: info: CoreCommandRouter::servicePushState Oct 25 11:19:26 volumio-shd volumio[797]: info: CoreStateMachine::pushState Oct 25 11:19:26 volumio-shd volumio[797]: info: CoreCommandRouter::volumioPushState Oct 25 11:19:26 volumio-shd volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 25 11:19:26 volumio-shd volumio[797]: Discovery: adding 8005427a-47f0-485f-85ec-0ee64dd4be46 Oct 25 11:19:26 volumio-shd volumio[797]: info: mDNS: Found device Volumio-shd Oct 25 11:19:26 volumio-shd volumio[797]: info: CoreCommandRouter::volumioGetState Oct 25 11:19:26 volumio-shd volumio[797]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 11:19:26 volumio-shd volumio[797]: Error: The value NaN is not a number Oct 25 11:19:26 volumio-shd volumio[797]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Oct 25 11:19:26 volumio-shd volumio[797]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Oct 25 11:19:26 volumio-shd volumio[797]: at ControllerVolumioDiscovery.pushMultiRoomStatusUpdate (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:287:25) Oct 25 11:19:26 volumio-shd volumio[797]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:10) Oct 25 11:19:26 volumio-shd volumio[797]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:202:12) Oct 25 11:19:26 volumio-shd volumio[797]: at emitTwo (events.js:126:13) Oct 25 11:19:26 volumio-shd volumio[797]: at Browser.emit (events.js:214:7) Oct 25 11:19:26 volumio-shd volumio[797]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Oct 25 11:19:26 volumio-shd volumio[797]: at next (/volumio/node_modules/mdns/lib/browser.js:104:7) Oct 25 11:19:26 volumio-shd volumio[797]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Oct 25 11:19:26 volumio-shd volumio[797]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 25 11:19:27 volumio-shd sudo[1030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-25 11:18 Oct 25 11:19:27 volumio-shd sudo[1030]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9" VOLUMIO_BE_VERSION="0cf482c24e7a7ab87af1081ea7d6d953621249a4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 23 09:46:56 CET 2022" VOLUMIO_VERSION="1.121" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="3b38c3dd18bd314d1ea0ffe96c6cfafa"