-- Logs begin at Wed 2024-04-10 22:34:12 UTC, end at Thu 2024-04-11 12:17:09 UTC. -- Apr 11 12:17:02 musical-fidelity systemd[1]: Time has been changed Apr 11 12:17:02 musical-fidelity volumio[1089]: info: Checking against Known Cards name Apr 11 12:17:02 musical-fidelity volumio[1089]: info: Loading plugin "qobuz"... Apr 11 12:17:03 musical-fidelity volumio[1089]: Starting albumart workers Apr 11 12:17:03 musical-fidelity volumio[1089]: Starting albumart workers Apr 11 12:17:03 musical-fidelity volumio[1089]: Starting albumart workers Apr 11 12:17:05 musical-fidelity volumio[1089]: info: Loading plugin "spop"... Apr 11 12:17:05 musical-fidelity volumio[1089]: info: Loading plugin "tidal"... Apr 11 12:17:07 musical-fidelity volumio[1089]: info: Loading plugin "gpios"... Apr 11 12:17:07 musical-fidelity volumio[1089]: error: ATTENTION!!!: Plugin gpios does not return adequate promise from onVolumioStart: please update! Apr 11 12:17:07 musical-fidelity volumio[1089]: info: Loading plugin "updater_comm"... Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Plugin mpdemulation is not enabled Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Loading plugin "rest_api"... Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Loading plugin "websocket"... Apr 11 12:17:08 musical-fidelity volumio[1089]: info: ___________ START PLUGINS ___________ Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Adding METAVOLUMIO REST API Endpoints Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 12:17:08 musical-fidelity volumio[1089]: info: [1712837828104] CoreMusicLibrary::Adding element Shairport-Sync Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 12:17:08 musical-fidelity sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name undefined Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Preparing CD Folders Apr 11 12:17:08 musical-fidelity sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Adding CD REST API Endpoints Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Detecting CD presence with Flag file Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Starting RAAT Plugin Apr 11 12:17:08 musical-fidelity sudo[1321]: pam_unix(sudo:session): session closed for user root Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Additional UI Settings Added for plugin music_service/raat Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Streaming services startup Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Starting Streaming Daemon Apr 11 12:17:08 musical-fidelity sudo[1336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 11 12:17:08 musical-fidelity sudo[1336]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 12:17:08 musical-fidelity systemd[1]: Stopping Volumio Streaming Daemon... Apr 11 12:17:08 musical-fidelity systemd[1]: Starting Volumio Streaming Daemon... Apr 11 12:17:08 musical-fidelity systemd[1]: Started Volumio Streaming Daemon. Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 12:17:08 musical-fidelity volumio[1089]: info: [1712837828259] CoreMusicLibrary::Adding element Webradio Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 12:17:08 musical-fidelity sudo[1336]: pam_unix(sudo:session): session closed for user root Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 12:17:08 musical-fidelity volumio-streaming-daemon[1347]: ############################ Apr 11 12:17:08 musical-fidelity volumio-streaming-daemon[1347]: # Volumio Streaming Daemon # Apr 11 12:17:08 musical-fidelity volumio-streaming-daemon[1347]: # Running on port 7777 # Apr 11 12:17:08 musical-fidelity volumio-streaming-daemon[1347]: ############################ Apr 11 12:17:08 musical-fidelity volumio-streaming-daemon[1347]: Checking variant in static cache Apr 11 12:17:08 musical-fidelity volumio-streaming-daemon[1347]: Enabled services: Apr 11 12:17:08 musical-fidelity volumio-streaming-daemon[1347]: 1) tidal Apr 11 12:17:08 musical-fidelity volumio-streaming-daemon[1347]: 2) qobuz Apr 11 12:17:08 musical-fidelity volumio[1089]: error: Hi Res Audio Failed Login: Missing Login Data Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 12:17:08 musical-fidelity volumio[1089]: [SpotifyConnect] Creating VLS config file Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: [SpotifyConnect] SpotifyConnect Daemon config issues! Apr 11 12:17:08 musical-fidelity volumio[1089]: [SpotifyConnect] volspotify config error: [ 'device-name = "undefined" # Name of the Spotify connect device', Apr 11 12:17:08 musical-fidelity volumio[1089]: [length]: 1 ] Apr 11 12:17:08 musical-fidelity volumio[1089]: [SpotifyConnect] Starting metadata listener Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Refreshing TIDAL token Apr 11 12:17:08 musical-fidelity sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Apr 11 12:17:08 musical-fidelity sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 12:17:08 musical-fidelity volumio[1089]: error: Plugin gpios does not return adequate promise from onStart: please update! Apr 11 12:17:08 musical-fidelity systemd[1]: Starting Volspotconnect2 Daemon... Apr 11 12:17:08 musical-fidelity systemd[1]: Started Volspotconnect2 Daemon. Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Loading i18n strings for locale en Apr 11 12:17:08 musical-fidelity sudo[1357]: pam_unix(sudo:session): session closed for user root Apr 11 12:17:08 musical-fidelity volumio[1089]: Updating browse sources language Apr 11 12:17:08 musical-fidelity volumio[1089]: Cannot find translation for sourceBluetooth Apr 11 12:17:08 musical-fidelity volumio[1089]: Cannot find translation for sourceUSB/PC Apr 11 12:17:08 musical-fidelity volumio[1089]: Cannot find translation for sourceShairport-Sync Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::initPlayerControls Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: BOOT COMPLETED Apr 11 12:17:08 musical-fidelity volumio[1089]: [Metrics] CommandRouter: 12s 449.29ms Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::Close All Modals sent Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::Close All Modals sent Apr 11 12:17:08 musical-fidelity volumio[1089]: Express server listening on port 3000 Apr 11 12:17:08 musical-fidelity volumio[1089]: [Metrics] WebUI: 13s 440.00ms Apr 11 12:17:08 musical-fidelity volumio[1089]: Volumio Calling Home Apr 11 12:17:08 musical-fidelity volumio[1362]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Apr 11 12:17:08 musical-fidelity volumio[1362]: Reading Config from "/tmp/volspotify.toml" Apr 11 12:17:08 musical-fidelity volumio[1362]: Malformed config key: missing field `Authentication` Apr 11 12:17:08 musical-fidelity systemd[1]: volspotconnect.service: main process exited, code=exited, status=1/FAILURE Apr 11 12:17:08 musical-fidelity systemd[1]: Unit volspotconnect.service entered failed state. Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreStateMachine::resetVolumioState Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreStateMachine::getcurrentVolume Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Stopping AccessToken refresher cron for QOBUZ Apr 11 12:17:08 musical-fidelity volumio[1089]: info: AccessToken refresher cron started for QOBUZ Apr 11 12:17:08 musical-fidelity kernel: uart-pl011 3f201000.serial: no DMA platform data Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 12:17:08 musical-fidelity volumio[1089]: info: Serial port opened successfully Apr 11 12:17:08 musical-fidelity sudo[1392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart leddaemon.service Apr 11 12:17:08 musical-fidelity sudo[1392]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 12:17:08 musical-fidelity systemd[1]: Starting LED Daemon Service... Apr 11 12:17:08 musical-fidelity systemd[1]: Started LED Daemon Service. Apr 11 12:17:08 musical-fidelity sudo[1392]: pam_unix(sudo:session): session closed for user root Apr 11 12:17:08 musical-fidelity led-daemon[1397]: Starting Network LED Daemon Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreStateMachine::pushState Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CorePlayQueue::getTrack 0 Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::volumioPushState Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreStateMachine::updateTrackBlock Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CorePlayQueue::getTrackBlock Apr 11 12:17:08 musical-fidelity volumio[1089]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 12:17:09 musical-fidelity volumio[1089]: info: Setting Device type: Raspberry PI Apr 11 12:17:09 musical-fidelity volumio[1089]: [SpotifyConnect] Vollibrespot Daemon service started! Apr 11 12:17:09 musical-fidelity volumio[1089]: [Metrics] SpotifyConnect: 0s 697.25ms Apr 11 12:17:09 musical-fidelity volumio[1089]: info: RAAT Albumart path created successfully Apr 11 12:17:09 musical-fidelity volumio[1089]: info: Bluetooth name changed to undefined Apr 11 12:17:09 musical-fidelity volumio[1089]: info: Shairport-Sync Stopped Apr 11 12:17:09 musical-fidelity volumio[1089]: info: MPD running with PID701 Apr 11 12:17:09 musical-fidelity volumio[1089]: ,establishing connection Apr 11 12:17:09 musical-fidelity volumio[1089]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 12:17:09 musical-fidelity volumio[1089]: TypeError: Cannot read property 'charAt' of undefined Apr 11 12:17:09 musical-fidelity volumio[1089]: at Timeout._onTimeout (/volumio/app/plugins/audio_interface/upnp/index.js:199:24) Apr 11 12:17:09 musical-fidelity volumio[1089]: at ontimeout (timers.js:482:11) Apr 11 12:17:09 musical-fidelity volumio[1089]: at tryOnTimeout (timers.js:317:5) Apr 11 12:17:09 musical-fidelity volumio[1089]: at Timer.listOnTimeout (timers.js:277:5) Apr 11 12:17:09 musical-fidelity volumio[1089]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 12:17:09 musical-fidelity sudo[1413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Apr 11 12:17:09 musical-fidelity sudo[1413]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 12:17:09 musical-fidelity sudo[1413]: pam_unix(sudo:session): session closed for user root Apr 11 12:17:09 musical-fidelity sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-11 12:16 Apr 11 12:17:09 musical-fidelity sudo[1430]: 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"