-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Tue 2025-04-29 20:22:29 UTC. -- Apr 29 20:21:49 volumio volumio[864]: info: CoreCommandRouter::volumioPlay Apr 29 20:21:49 volumio volumio[864]: info: CoreStateMachine::play index undefined Apr 29 20:21:49 volumio volumio[864]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 20:21:49 volumio volumio[864]: info: CorePlayQueue::getTrack 3 Apr 29 20:21:49 volumio volumio[864]: info: CoreStateMachine::startPlaybackTimer Apr 29 20:21:49 volumio volumio[864]: info: CorePlayQueue::getTrack 3 Apr 29 20:21:49 volumio volumio[864]: info: [1745958109546] ControllerSpotify::clearAddPlayTrack Apr 29 20:21:49 volumio volumio[864]: info: Setting this device active Apr 29 20:21:50 volumio volumio[864]: error: Failed to Set Device Active: Error: Bad Request Device ID: undefined Apr 29 20:21:57 volumio volumio[864]: info: VolumeController::SetAlsaVolume53 Apr 29 20:21:57 volumio volumio[864]: info: CoreStateMachine::pushState Apr 29 20:21:57 volumio volumio[864]: info: CorePlayQueue::getTrack 3 Apr 29 20:21:57 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 20:21:57 volumio volumio[864]: info: CoreCommandRouter::volumioPushState Apr 29 20:21:58 volumio volumio[864]: info: VolumeController::SetAlsaVolume84 Apr 29 20:21:58 volumio volumio[864]: info: CoreStateMachine::pushState Apr 29 20:21:58 volumio volumio[864]: info: CorePlayQueue::getTrack 3 Apr 29 20:21:58 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 20:21:58 volumio volumio[864]: info: CoreCommandRouter::volumioPushState Apr 29 20:21:58 volumio volumio[864]: info: VolumeController::SetAlsaVolume94 Apr 29 20:21:58 volumio volumio[864]: info: CoreStateMachine::pushState Apr 29 20:21:58 volumio volumio[864]: info: CorePlayQueue::getTrack 3 Apr 29 20:21:58 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 20:21:58 volumio volumio[864]: info: CoreCommandRouter::volumioPushState Apr 29 20:21:58 volumio volumio[864]: info: VolumeController::SetAlsaVolume95 Apr 29 20:21:58 volumio volumio[864]: info: CoreStateMachine::pushState Apr 29 20:21:58 volumio volumio[864]: info: CorePlayQueue::getTrack 3 Apr 29 20:21:58 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 20:21:58 volumio volumio[864]: info: CoreCommandRouter::volumioPushState Apr 29 20:21:58 volumio volumio[864]: info: VolumeController::SetAlsaVolume96 Apr 29 20:21:59 volumio volumio[864]: info: CoreStateMachine::pushState Apr 29 20:21:59 volumio volumio[864]: info: CorePlayQueue::getTrack 3 Apr 29 20:21:59 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 20:21:59 volumio volumio[864]: info: CoreCommandRouter::volumioPushState Apr 29 20:22:18 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 29 20:22:18 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 29 20:22:25 volumio volumio[864]: info: Enabling plugin fusiondsp Apr 29 20:22:25 volumio volumio[864]: info: Loading plugin "fusiondsp"... Apr 29 20:22:26 volumio volumio[864]: info: Applying required configuration parameters for plugin fusiondsp Apr 29 20:22:26 volumio volumio[864]: info: Preparing to generate the ALSA configuration file Apr 29 20:22:26 volumio volumio[864]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 29 20:22:26 volumio volumio[864]: info: Reading ALSA contributions from plugins. Apr 29 20:22:26 volumio volumio[864]: info: Asound.conf file written Apr 29 20:22:26 volumio sudo[1960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 29 20:22:26 volumio sudo[1960]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:22:26 volumio sudo[1960]: pam_unix(sudo:session): session closed for user root Apr 29 20:22:27 volumio volumio[864]: info: Output device has changed, restarting MPD Apr 29 20:22:27 volumio sudo[1965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 20:22:27 volumio sudo[1965]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:22:27 volumio volumio[864]: info: Output device has changed, restarting Shairport Sync Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 20:22:27 volumio sudo[1965]: pam_unix(sudo:session): session closed for user root Apr 29 20:22:27 volumio sudo[1967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 20:22:27 volumio sudo[1967]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:22:27 volumio systemd[1]: Stopping Music Player Daemon... Apr 29 20:22:27 volumio volumio[864]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 20:22:27 volumio volumio[864]: [SpotifyConnect] Creating VLS config file Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: PLUGIN START: fusiondsp Apr 29 20:22:27 volumio systemd[1]: mpd.service: Succeeded. Apr 29 20:22:27 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 20:22:27 volumio volumio[864]: info: Loading i18n strings for locale de Apr 29 20:22:27 volumio systemd[1]: Starting Music Player Daemon... Apr 29 20:22:27 volumio volumio[864]: info: Plugin touch_display has duplicated i18n key TOUCH_DISPLAY. It is ignored. Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: mixtype--------------------- Hardware Apr 29 20:22:27 volumio volumio[864]: info: Preparing to generate the ALSA configuration file Apr 29 20:22:27 volumio volumio[864]: info: Done. Apr 29 20:22:27 volumio volumio[864]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 29 20:22:27 volumio volumio[864]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 29 20:22:27 volumio volumio[864]: info: Reading ALSA contributions from plugins. Apr 29 20:22:27 volumio volumio[864]: info: MPD Permissions set Apr 29 20:22:27 volumio sudo[1975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 29 20:22:27 volumio sudo[1975]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 29 20:22:27 volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 29 20:22:27 volumio systemd[1]: volspotconnect.service: Succeeded. Apr 29 20:22:27 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Apr 29 20:22:27 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 29 20:22:27 volumio sudo[1975]: pam_unix(sudo:session): session closed for user root Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[1980]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 29 20:22:27 volumio volumio[1980]: Reading Config from "/tmp/volspotify.toml" Apr 29 20:22:27 volumio volumio[1980]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 29 20:22:27 volumio volumio[864]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 29 20:22:27 volumio volumio[864]: info: Starting Shairport Sync Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 29 20:22:27 volumio volumio[864]: info: Asound.conf file unchanged, so no further update is needed Apr 29 20:22:27 volumio volumio[864]: info: Output device has changed, restarting MPD Apr 29 20:22:27 volumio sudo[1986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 20:22:27 volumio sudo[1986]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:22:27 volumio volumio[864]: info: Output device has changed, restarting Shairport Sync Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 20:22:27 volumio sudo[1989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 20:22:27 volumio sudo[1989]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:22:27 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 20:22:27 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 20:22:27 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 20:22:27 volumio sudo[1991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 20:22:27 volumio sudo[1991]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:22:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 20:22:27 volumio sudo[1989]: pam_unix(sudo:session): session closed for user root Apr 29 20:22:27 volumio volumio[1980]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 29 20:22:27 volumio sudo[1986]: pam_unix(sudo:session): session closed for user root Apr 29 20:22:27 volumio volumio[864]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 20:22:27 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 29 20:22:27 volumio systemd[1]: mpd.service: Succeeded. Apr 29 20:22:27 volumio volumio[864]: [SpotifyConnect] Creating VLS config file Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: [SpotifyConnect] Restarting Vollibrespot Daemon Apr 29 20:22:27 volumio systemd[1]: Starting Music Player Daemon... Apr 29 20:22:27 volumio volumio[864]: info: MPD Permissions set Apr 29 20:22:27 volumio volumio[864]: info: Shairport-Sync Started Apr 29 20:22:27 volumio sudo[2008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect.service Apr 29 20:22:27 volumio sudo[2008]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:22:27 volumio volumio[1980]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:443" Apr 29 20:22:27 volumio volumio[864]: info: effect true Apr 29 20:22:27 volumio volumio[864]: info: Dsp mode set is PEQ Apr 29 20:22:27 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Apr 29 20:22:27 volumio systemd[1]: volspotconnect.service: Main process exited, code=killed, status=15/TERM Apr 29 20:22:27 volumio systemd[1]: volspotconnect.service: Succeeded. Apr 29 20:22:27 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Apr 29 20:22:27 volumio systemd[1]: Started Volspotconnect2 Daemon. Apr 29 20:22:27 volumio sudo[2008]: pam_unix(sudo:session): session closed for user root Apr 29 20:22:27 volumio volumio[2010]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-05-31 Apr 29 20:22:27 volumio volumio[2010]: Reading Config from "/tmp/volspotify.toml" Apr 29 20:22:27 volumio volumio[2010]: [Vollibrespot] : Using Alsa backend with device: volumio Apr 29 20:22:27 volumio volumio[2010]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:22:27 volumio volumio[864]: info: << convolution filters enabled Apr 29 20:22:27 volumio volumio[864]: info: tools file to play : Apr 29 20:22:27 volumio volumio[2010]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:443" Apr 29 20:22:27 volumio volumio[864]: [SpotifyConnect] Vollibrespot Daemon service restarted! Apr 29 20:22:27 volumio volumio[864]: info: Starting Shairport Sync Apr 29 20:22:28 volumio mpd[2017]: Apr 29 20:22 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 20:22:28 volumio mpd[2017]: Apr 29 20:22 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 29 20:22:28 volumio mpd[2017]: Apr 29 20:22 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 29 20:22:29 volumio volumio[864]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 20:22:29 volumio volumio[864]: TypeError: Cannot read property 'off' of undefined Apr 29 20:22:29 volumio volumio[864]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:93:15) Apr 29 20:22:29 volumio volumio[864]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Apr 29 20:22:29 volumio volumio[864]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1869:8) Apr 29 20:22:29 volumio volumio[864]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1498:29) Apr 29 20:22:29 volumio volumio[864]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1264:47) Apr 29 20:22:29 volumio volumio[864]: at Socket.emit (events.js:315:20) Apr 29 20:22:29 volumio volumio[864]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 29 20:22:29 volumio volumio[864]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 29 20:22:29 volumio volumio[864]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 20:22:29 volumio systemd[1]: Started Music Player Daemon. Apr 29 20:22:29 volumio sudo[1991]: pam_unix(sudo:session): session closed for user root Apr 29 20:22:29 volumio sudo[1967]: pam_unix(sudo:session): session closed for user root Apr 29 20:22:29 volumio sudo[2023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 20:22:29 volumio sudo[2023]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:22:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 20:22:29 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 20:22:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 20:22:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 20:22:29 volumio sudo[2023]: pam_unix(sudo:session): session closed for user root Apr 29 20:22:29 volumio sudo[2039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-29 20:21 Apr 29 20:22:29 volumio sudo[2039]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="85acf7bbbceb3e3dec447156a39a88033f921210" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 30 Sep 2022 10:43:40 AM CEST" VOLUMIO_VERSION="3.378" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4bc817297375b72097a1fade15c6518b"