-- Logs begin at Mon 2025-12-22 19:32:58 UTC, end at Mon 2025-12-22 21:32:39 UTC. -- Dec 22 21:32:31 musical-fidelity systemd[1]: Time has been changed Dec 22 21:32:31 musical-fidelity volumio[1046]: Forking 3 albumart workers Dec 22 21:32:31 musical-fidelity volumio[1046]: info: Adding inputs REST Endpoints Dec 22 21:32:31 musical-fidelity volumio[1046]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/inputs Dec 22 21:32:31 musical-fidelity volumio[1046]: info: Scanning Audio Inputs Dec 22 21:32:31 musical-fidelity volumio[1046]: info: Checking against Known Cards name Dec 22 21:32:31 musical-fidelity volumio[1046]: info: Loading plugin "qobuz"... Dec 22 21:32:32 musical-fidelity volumio[1046]: Starting albumart workers Dec 22 21:32:33 musical-fidelity volumio[1046]: Starting albumart workers Dec 22 21:32:33 musical-fidelity volumio[1046]: Starting albumart workers Dec 22 21:32:34 musical-fidelity volumio[1046]: info: Loading plugin "spop"... Dec 22 21:32:35 musical-fidelity volumio[1046]: info: Loading plugin "tidal"... Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Loading plugin "gpios"... Dec 22 21:32:37 musical-fidelity volumio[1046]: error: ATTENTION!!!: Plugin gpios does not return adequate promise from onVolumioStart: please update! Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Loading plugin "updater_comm"... Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Plugin mpdemulation is not enabled Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Loading plugin "rest_api"... Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Loading plugin "websocket"... Dec 22 21:32:37 musical-fidelity volumio[1046]: info: ___________ START PLUGINS ___________ Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Adding METAVOLUMIO REST API Endpoints Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 22 21:32:37 musical-fidelity volumio[1046]: info: [1766439157429] CoreMusicLibrary::Adding element Shairport-Sync Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 21:32:37 musical-fidelity sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name undefined Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Preparing CD Folders Dec 22 21:32:37 musical-fidelity sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Adding CD REST API Endpoints Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Detecting CD presence with Flag file Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Starting RAAT Plugin Dec 22 21:32:37 musical-fidelity sudo[1277]: pam_unix(sudo:session): session closed for user root Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Additional UI Settings Added for plugin music_service/raat Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Streaming services startup Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Starting Streaming Daemon Dec 22 21:32:37 musical-fidelity sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 22 21:32:37 musical-fidelity volumio[1046]: info: [1766439157563] CoreMusicLibrary::Adding element Webradio Dec 22 21:32:37 musical-fidelity sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 22 21:32:37 musical-fidelity systemd[1]: Stopping Volumio Streaming Daemon... Dec 22 21:32:37 musical-fidelity volumio[1046]: error: Hi Res Audio Failed Login: Missing Login Data Dec 22 21:32:37 musical-fidelity systemd[1]: Starting Volumio Streaming Daemon... Dec 22 21:32:37 musical-fidelity systemd[1]: Started Volumio Streaming Daemon. Dec 22 21:32:37 musical-fidelity sudo[1293]: pam_unix(sudo:session): session closed for user root Dec 22 21:32:37 musical-fidelity volumio-streaming-daemon[1302]: ############################ Dec 22 21:32:37 musical-fidelity volumio-streaming-daemon[1302]: # Volumio Streaming Daemon # Dec 22 21:32:37 musical-fidelity volumio-streaming-daemon[1302]: # Running on port 7777 # Dec 22 21:32:37 musical-fidelity volumio-streaming-daemon[1302]: ############################ Dec 22 21:32:37 musical-fidelity volumio-streaming-daemon[1302]: Checking variant in static cache Dec 22 21:32:37 musical-fidelity volumio-streaming-daemon[1302]: Enabled services: Dec 22 21:32:37 musical-fidelity volumio-streaming-daemon[1302]: 1) tidal Dec 22 21:32:37 musical-fidelity volumio-streaming-daemon[1302]: 2) qobuz Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 22 21:32:37 musical-fidelity volumio[1046]: [SpotifyConnect] Creating VLS config file Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: [SpotifyConnect] SpotifyConnect Daemon config issues! Dec 22 21:32:37 musical-fidelity volumio[1046]: [SpotifyConnect] volspotify config error: [ 'device-name = "undefined" # Name of the Spotify connect device', Dec 22 21:32:37 musical-fidelity volumio[1046]: [length]: 1 ] Dec 22 21:32:37 musical-fidelity volumio[1046]: [SpotifyConnect] Starting metadata listener Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Refreshing TIDAL token Dec 22 21:32:37 musical-fidelity sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Dec 22 21:32:37 musical-fidelity sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:32:37 musical-fidelity volumio[1046]: error: Plugin gpios does not return adequate promise from onStart: please update! Dec 22 21:32:37 musical-fidelity systemd[1]: Starting Volspotconnect2 Daemon... Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Loading i18n strings for locale en Dec 22 21:32:37 musical-fidelity systemd[1]: Started Volspotconnect2 Daemon. Dec 22 21:32:37 musical-fidelity sudo[1311]: pam_unix(sudo:session): session closed for user root Dec 22 21:32:37 musical-fidelity volumio[1046]: Updating browse sources language Dec 22 21:32:37 musical-fidelity volumio[1046]: Cannot find translation for sourceBluetooth Dec 22 21:32:37 musical-fidelity volumio[1046]: Cannot find translation for sourceUSB/PC Dec 22 21:32:37 musical-fidelity volumio[1046]: Cannot find translation for sourceShairport-Sync Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::initPlayerControls Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: BOOT COMPLETED Dec 22 21:32:37 musical-fidelity volumio[1046]: [Metrics] CommandRouter: 12s 233.35ms Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::Close All Modals sent Dec 22 21:32:37 musical-fidelity volumio[1046]: Express server listening on port 3000 Dec 22 21:32:37 musical-fidelity volumio[1046]: [Metrics] WebUI: 13s 147.86ms Dec 22 21:32:37 musical-fidelity volumio[1046]: Volumio Calling Home Dec 22 21:32:37 musical-fidelity volumio[1316]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Dec 22 21:32:37 musical-fidelity volumio[1316]: Reading Config from "/tmp/volspotify.toml" Dec 22 21:32:37 musical-fidelity volumio[1316]: Malformed config key: missing field `Authentication` Dec 22 21:32:37 musical-fidelity systemd[1]: volspotconnect.service: main process exited, code=exited, status=1/FAILURE Dec 22 21:32:37 musical-fidelity systemd[1]: Unit volspotconnect.service entered failed state. Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreStateMachine::resetVolumioState Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreStateMachine::getcurrentVolume Dec 22 21:32:37 musical-fidelity volumio[1046]: info: CoreCommandRouter::volumioRetrievevolume Dec 22 21:32:37 musical-fidelity volumio[1046]: info: Stopping AccessToken refresher cron for QOBUZ Dec 22 21:32:37 musical-fidelity volumio[1046]: info: AccessToken refresher cron started for QOBUZ Dec 22 21:32:37 musical-fidelity kernel: uart-pl011 3f201000.serial: no DMA platform data Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 22 21:32:38 musical-fidelity volumio[1046]: info: Serial port opened successfully Dec 22 21:32:38 musical-fidelity sudo[1346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart leddaemon.service Dec 22 21:32:38 musical-fidelity sudo[1346]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:32:38 musical-fidelity systemd[1]: Starting LED Daemon Service... Dec 22 21:32:38 musical-fidelity systemd[1]: Started LED Daemon Service. Dec 22 21:32:38 musical-fidelity sudo[1346]: pam_unix(sudo:session): session closed for user root Dec 22 21:32:38 musical-fidelity led-daemon[1351]: Starting Network LED Daemon Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CoreStateMachine::pushState Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CorePlayQueue::getTrack 0 Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CoreCommandRouter::volumioPushState Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CoreStateMachine::updateTrackBlock Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CorePlayQueue::getTrackBlock Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CoreCommandRouter::volumioRetrievevolume Dec 22 21:32:38 musical-fidelity volumio[1046]: info: Volumio called home Dec 22 21:32:38 musical-fidelity volumio[1046]: info: Setting Device type: Raspberry PI Dec 22 21:32:38 musical-fidelity volumio[1046]: [SpotifyConnect] Vollibrespot Daemon service started! Dec 22 21:32:38 musical-fidelity volumio[1046]: [Metrics] SpotifyConnect: 0s 726.82ms Dec 22 21:32:38 musical-fidelity volumio[1046]: info: RAAT Albumart path created successfully Dec 22 21:32:38 musical-fidelity volumio[1046]: info: Bluetooth name changed to undefined Dec 22 21:32:38 musical-fidelity volumio[1046]: info: Shairport-Sync Stopped Dec 22 21:32:38 musical-fidelity volumio[1046]: info: MPD running with PID669 Dec 22 21:32:38 musical-fidelity volumio[1046]: ,establishing connection Dec 22 21:32:38 musical-fidelity sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 22 21:32:38 musical-fidelity sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 22 21:32:38 musical-fidelity sudo[1367]: pam_unix(sudo:session): session closed for user root Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CoreStateMachine::pushState Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CorePlayQueue::getTrack 0 Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CoreCommandRouter::volumioPushState Dec 22 21:32:38 musical-fidelity volumio[1046]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 22 21:32:38 musical-fidelity volumio[1046]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 21:32:38 musical-fidelity volumio[1046]: TypeError: Cannot read property 'charAt' of undefined Dec 22 21:32:38 musical-fidelity volumio[1046]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24) Dec 22 21:32:38 musical-fidelity volumio[1046]: at ontimeout (timers.js:482:11) Dec 22 21:32:38 musical-fidelity volumio[1046]: at tryOnTimeout (timers.js:317:5) Dec 22 21:32:38 musical-fidelity volumio[1046]: at Timer.listOnTimeout (timers.js:277:5) Dec 22 21:32:38 musical-fidelity volumio[1046]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 22 21:32:39 musical-fidelity sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-22 21:31 Dec 22 21:32:39 musical-fidelity sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="mf" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 16:55:24 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Musical Fidelity" VOLUMIO_MODEL="MX-Stream" VOLUMIO_VENDOR_MODEL="Musical Fidelity MX-Stream" VOLUMIO_HASH="feef4003d1cbcf074f611a1d9cb9a86e"