-- Logs begin at Thu 2019-02-14 05:12:00 EST, end at Fri 2024-04-12 11:54:30 EDT. -- Apr 12 11:53:09 sounds kernel: hwmon hwmon1: Voltage normalised Apr 12 11:53:11 sounds kernel: hwmon hwmon1: Undervoltage detected! Apr 12 11:53:12 sounds volumio[956]: info: Enabling plugin volparametriceq Apr 12 11:53:12 sounds volumio[956]: info: Loading plugin "volparametriceq"... Apr 12 11:53:12 sounds volumio[956]: info: PLUGIN START: volparametriceq Apr 12 11:53:12 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:12 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:12 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:12 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:12 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:12 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:12 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:12 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:12 sounds volumio[956]: info: volparametriceq Started Apr 12 11:53:12 sounds volumio[956]: info: Done. Apr 12 11:53:12 sounds sudo[6031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Apr 12 11:53:12 sounds sudo[6031]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:12 sounds volumio[956]: 1 30 0.9 2 Apr 12 11:53:12 sounds volumio[956]: 1 500 0.9 2 Apr 12 11:53:12 sounds volumio[956]: 1 2000 0.9 2 Apr 12 11:53:12 sounds volumio[956]: 1 10000 0.9 2 Apr 12 11:53:12 sounds volumio[956]: info: asound.conf file written Apr 12 11:53:13 sounds sudo[6031]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:13 sounds sudo[6034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/asoundrc /etc/asound.conf Apr 12 11:53:13 sounds sudo[6034]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:13 sounds sudo[6034]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:13 sounds volumio[956]: No state is present for card Loopback Apr 12 11:53:13 sounds volumio[956]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Apr 12 11:53:13 sounds volumio[956]: Hardware is initialized using a generic method Apr 12 11:53:13 sounds volumio[956]: No state is present for card Loopback Apr 12 11:53:13 sounds systemd-udevd[6041]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 7' failed with exit code 99. Apr 12 11:53:13 sounds volumio[956]: info: added device { Apr 12 11:53:13 sounds volumio[956]: "syspath": "/sys/bus/platform/drivers/snd_aloop", Apr 12 11:53:13 sounds volumio[956]: "ACTION": "add", Apr 12 11:53:13 sounds volumio[956]: "DEVPATH": "/bus/platform/drivers/snd_aloop", Apr 12 11:53:13 sounds volumio[956]: "SEQNUM": "1642", Apr 12 11:53:13 sounds volumio[956]: "SUBSYSTEM": "drivers", Apr 12 11:53:13 sounds volumio[956]: "USEC_INITIALIZED": "2663959706" Apr 12 11:53:13 sounds volumio[956]: } Apr 12 11:53:13 sounds volumio[956]: info: snd_aloop loaded Apr 12 11:53:13 sounds volumio[956]: info: added device { Apr 12 11:53:13 sounds volumio[956]: "syspath": "/sys/module/snd_aloop", Apr 12 11:53:13 sounds volumio[956]: "ACTION": "add", Apr 12 11:53:13 sounds volumio[956]: "DEVPATH": "/module/snd_aloop", Apr 12 11:53:13 sounds volumio[956]: "SEQNUM": "1651", Apr 12 11:53:13 sounds volumio[956]: "SUBSYSTEM": "module", Apr 12 11:53:13 sounds volumio[956]: "USEC_INITIALIZED": "2663963531" Apr 12 11:53:13 sounds volumio[956]: } Apr 12 11:53:13 sounds volumio[956]: info: added device { Apr 12 11:53:13 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_aloop.0", Apr 12 11:53:13 sounds volumio[956]: "ACTION": "add", Apr 12 11:53:13 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_aloop.0", Apr 12 11:53:13 sounds volumio[956]: "DRIVER": "snd_aloop", Apr 12 11:53:13 sounds volumio[956]: "MODALIAS": "platform:snd_aloop", Apr 12 11:53:13 sounds volumio[956]: "SEQNUM": "1643", Apr 12 11:53:13 sounds volumio[956]: "SUBSYSTEM": "platform", Apr 12 11:53:13 sounds volumio[956]: "USEC_INITIALIZED": "2664016680" Apr 12 11:53:13 sounds volumio[956]: } Apr 12 11:53:13 sounds volumio[956]: info: added device { Apr 12 11:53:13 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_aloop.0/sound/card7", Apr 12 11:53:13 sounds volumio[956]: "ACTION": "add", Apr 12 11:53:13 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_aloop.0/sound/card7", Apr 12 11:53:13 sounds volumio[956]: "ID_FOR_SEAT": "sound-platform-snd_aloop_0", Apr 12 11:53:13 sounds volumio[956]: "ID_PATH": "platform-snd_aloop.0", Apr 12 11:53:13 sounds volumio[956]: "ID_PATH_TAG": "platform-snd_aloop_0", Apr 12 11:53:13 sounds volumio[956]: "SEQNUM": "1644", Apr 12 11:53:13 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:53:13 sounds volumio[956]: "SYSTEMD_WANTS": "sound.target", Apr 12 11:53:13 sounds volumio[956]: "TAGS": ":systemd:seat:", Apr 12 11:53:13 sounds volumio[956]: "USEC_INITIALIZED": "2664060914" Apr 12 11:53:13 sounds volumio[956]: } Apr 12 11:53:13 sounds volumio[956]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 11:53:13 sounds volumio[956]: info: added device { Apr 12 11:53:13 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_aloop.0/sound/card7/pcmC7D0c", Apr 12 11:53:13 sounds volumio[956]: "ACTION": "add", Apr 12 11:53:13 sounds volumio[956]: "DEVNAME": "/dev/snd/pcmC7D0c", Apr 12 11:53:13 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_aloop.0/sound/card7/pcmC7D0c", Apr 12 11:53:13 sounds volumio[956]: "DEVTYPE": "pcm", Apr 12 11:53:13 sounds volumio[956]: "MAJOR": "116", Apr 12 11:53:13 sounds volumio[956]: "MINOR": "8", Apr 12 11:53:13 sounds volumio[956]: "SEQNUM": "1646", Apr 12 11:53:13 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:53:13 sounds volumio[956]: "TAGS": ":uaccess:", Apr 12 11:53:13 sounds volumio[956]: "USEC_INITIALIZED": "2664069684" Apr 12 11:53:13 sounds volumio[956]: } Apr 12 11:53:13 sounds volumio[956]: info: added device { Apr 12 11:53:13 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_aloop.0/sound/card7/pcmC7D1p", Apr 12 11:53:13 sounds volumio[956]: "ACTION": "add", Apr 12 11:53:13 sounds volumio[956]: "DEVNAME": "/dev/snd/pcmC7D1p", Apr 12 11:53:13 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_aloop.0/sound/card7/pcmC7D1p", Apr 12 11:53:13 sounds volumio[956]: "DEVTYPE": "pcm", Apr 12 11:53:13 sounds volumio[956]: "MAJOR": "116", Apr 12 11:53:13 sounds volumio[956]: "MINOR": "9", Apr 12 11:53:13 sounds volumio[956]: "SEQNUM": "1647", Apr 12 11:53:13 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:53:13 sounds volumio[956]: "TAGS": ":uaccess:", Apr 12 11:53:13 sounds volumio[956]: "USEC_INITIALIZED": "2664069982" Apr 12 11:53:13 sounds volumio[956]: } Apr 12 11:53:13 sounds volumio[956]: info: added device { Apr 12 11:53:13 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_aloop.0/sound/card7/pcmC7D0p", Apr 12 11:53:13 sounds volumio[956]: "ACTION": "add", Apr 12 11:53:13 sounds volumio[956]: "DEVNAME": "/dev/snd/pcmC7D0p", Apr 12 11:53:13 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_aloop.0/sound/card7/pcmC7D0p", Apr 12 11:53:13 sounds volumio[956]: "DEVTYPE": "pcm", Apr 12 11:53:13 sounds volumio[956]: "MAJOR": "116", Apr 12 11:53:13 sounds volumio[956]: "MINOR": "7", Apr 12 11:53:13 sounds volumio[956]: "SEQNUM": "1645", Apr 12 11:53:13 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:53:13 sounds volumio[956]: "TAGS": ":uaccess:", Apr 12 11:53:13 sounds volumio[956]: "USEC_INITIALIZED": "2664074562" Apr 12 11:53:13 sounds volumio[956]: } Apr 12 11:53:13 sounds volumio[956]: info: added device { Apr 12 11:53:13 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_aloop.0/sound/card7/pcmC7D1c", Apr 12 11:53:13 sounds volumio[956]: "ACTION": "add", Apr 12 11:53:13 sounds volumio[956]: "DEVNAME": "/dev/snd/pcmC7D1c", Apr 12 11:53:13 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_aloop.0/sound/card7/pcmC7D1c", Apr 12 11:53:13 sounds volumio[956]: "DEVTYPE": "pcm", Apr 12 11:53:13 sounds volumio[956]: "MAJOR": "116", Apr 12 11:53:13 sounds volumio[956]: "MINOR": "10", Apr 12 11:53:13 sounds volumio[956]: "SEQNUM": "1648", Apr 12 11:53:13 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:53:13 sounds volumio[956]: "TAGS": ":uaccess:", Apr 12 11:53:13 sounds volumio[956]: "USEC_INITIALIZED": "2664086090" Apr 12 11:53:13 sounds volumio[956]: } Apr 12 11:53:13 sounds volumio[956]: info: added device { Apr 12 11:53:13 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_aloop.0/sound/card7/controlC7", Apr 12 11:53:13 sounds volumio[956]: "ACTION": "add", Apr 12 11:53:13 sounds volumio[956]: "DEVLINKS": "/dev/snd/by-path/platform-snd_aloop.0", Apr 12 11:53:13 sounds volumio[956]: "DEVNAME": "/dev/snd/controlC7", Apr 12 11:53:13 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_aloop.0/sound/card7/controlC7", Apr 12 11:53:13 sounds volumio[956]: "ID_PATH": "platform-snd_aloop.0", Apr 12 11:53:13 sounds volumio[956]: "ID_PATH_TAG": "platform-snd_aloop_0", Apr 12 11:53:13 sounds volumio[956]: "MAJOR": "116", Apr 12 11:53:13 sounds volumio[956]: "MINOR": "11", Apr 12 11:53:13 sounds volumio[956]: "SEQNUM": "1649", Apr 12 11:53:13 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:53:13 sounds volumio[956]: "TAGS": ":uaccess:", Apr 12 11:53:13 sounds volumio[956]: "USEC_INITIALIZED": "2664103266" Apr 12 11:53:13 sounds volumio[956]: } Apr 12 11:53:17 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC Apr 12 11:53:17 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:53:17 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 12 11:53:17 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 11:53:17 sounds volumio[956]: warn: Unable to locate the device Headphones through volparametriceq plugin a reboot may be required. Apr 12 11:53:17 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 11:53:17 sounds volumio[956]: info: Output is Loopback, do not update Mixer Apr 12 11:53:17 sounds volumio[956]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 11:53:17 sounds volumio[956]: info: Preparing to generate the ALSA configuration file Apr 12 11:53:18 sounds sudo[6050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Apr 12 11:53:18 sounds sudo[6050]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:18 sounds sudo[6050]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:18 sounds volumio[956]: info: No Overlays Loaded Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 12 11:53:18 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 12 11:53:18 sounds volumio[956]: info: Asound.conf file written Apr 12 11:53:19 sounds sudo[6057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 12 11:53:19 sounds sudo[6057]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:19 sounds sudo[6057]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:19 sounds volumio[956]: No state is present for card Loopback Apr 12 11:53:19 sounds volumio[956]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Apr 12 11:53:19 sounds volumio[956]: Hardware is initialized using a generic method Apr 12 11:53:19 sounds volumio[956]: No state is present for card Loopback Apr 12 11:53:19 sounds volumio[956]: info: Output device has changed, restarting MPD Apr 12 11:53:19 sounds sudo[6062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 11:53:19 sounds sudo[6062]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:19 sounds volumio[956]: info: Output device has changed, restarting Shairport Sync Apr 12 11:53:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:53:19 sounds sudo[6062]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:19 sounds sudo[6065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 11:53:19 sounds sudo[6065]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:19 sounds systemd[1]: Stopping Music Player Daemon... Apr 12 11:53:19 sounds volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 11:53:19 sounds volumio[956]: info: Output device has changed, restarting MPD Apr 12 11:53:19 sounds sudo[6071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 11:53:19 sounds sudo[6071]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:19 sounds sudo[6071]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:19 sounds volumio[956]: info: Output device has changed, restarting Shairport Sync Apr 12 11:53:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:53:19 sounds sudo[6074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 11:53:19 sounds sudo[6074]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:19 sounds volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 11:53:20 sounds volumio[956]: info: MPD Permissions set Apr 12 11:53:20 sounds volumio[956]: info: MPD Permissions set Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:53:20 sounds volumio[956]: info: Starting Shairport Sync Apr 12 11:53:20 sounds volumio[956]: info: Starting Shairport Sync Apr 12 11:53:20 sounds sudo[6088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 11:53:20 sounds sudo[6088]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:20 sounds sudo[6090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 11:53:20 sounds sudo[6090]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:20 sounds systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 12 11:53:21 sounds systemd[1]: shairport-sync.service: Succeeded. Apr 12 11:53:21 sounds systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 12 11:53:21 sounds systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 12 11:53:21 sounds sudo[6088]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:21 sounds sudo[6090]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:21 sounds volumio[956]: info: Shairport-Sync Started Apr 12 11:53:21 sounds volumio[956]: info: Shairport-Sync Started Apr 12 11:53:22 sounds systemd[1]: mpd.service: Succeeded. Apr 12 11:53:22 sounds systemd[1]: Stopped Music Player Daemon. Apr 12 11:53:22 sounds systemd[1]: Starting Music Player Daemon... Apr 12 11:53:24 sounds volumio[956]: { Apr 12 11:53:24 sounds volumio[956]: device: '1', Apr 12 11:53:24 sounds volumio[956]: name: 'Headphones', Apr 12 11:53:24 sounds volumio[956]: mixer: 'PCM', Apr 12 11:53:24 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:53:24 sounds volumio[956]: maxvolume: '100', Apr 12 11:53:24 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:53:24 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:53:24 sounds volumio[956]: volumesteps: '1' Apr 12 11:53:24 sounds volumio[956]: } Apr 12 11:53:24 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:53:24 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:53:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:53:24 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:53:24 sounds volumio[956]: info: VolumeController:: Volume=86 Mute =false Apr 12 11:53:24 sounds volumio[956]: info: CoreStateMachine::pushState Apr 12 11:53:24 sounds volumio[956]: info: CorePlayQueue::getTrack 0 Apr 12 11:53:24 sounds volumio[956]: info: CoreCommandRouter::volumioPushState Apr 12 11:53:24 sounds volumio[956]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Apr 12 11:53:24 sounds volumio[956]: { Apr 12 11:53:24 sounds volumio[956]: device: '1', Apr 12 11:53:24 sounds volumio[956]: name: 'Headphones', Apr 12 11:53:24 sounds volumio[956]: mixer: 'PCM', Apr 12 11:53:24 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:53:24 sounds volumio[956]: maxvolume: '100', Apr 12 11:53:24 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:53:24 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:53:24 sounds volumio[956]: volumesteps: '1' Apr 12 11:53:24 sounds volumio[956]: } Apr 12 11:53:24 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:53:24 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:53:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:53:24 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:53:25 sounds volumio[956]: info: VolumeController:: Volume=86 Mute =false Apr 12 11:53:25 sounds volumio[956]: info: CoreStateMachine::pushState Apr 12 11:53:25 sounds volumio[956]: info: CorePlayQueue::getTrack 0 Apr 12 11:53:25 sounds volumio[956]: info: CoreCommandRouter::volumioPushState Apr 12 11:53:25 sounds volumio[956]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Apr 12 11:53:26 sounds sudo[6105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volparametriceq.service Apr 12 11:53:26 sounds sudo[6105]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:26 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:53:26 sounds sudo[6105]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:26 sounds volumio[956]: info: Alsaloop bridge ok Apr 12 11:53:26 sounds volumio[6107]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:53:26 sounds volumio[6107]: playback outplugin open error: No such file or directory Apr 12 11:53:26 sounds volumio[6107]: Loopback initialization failure. Apr 12 11:53:26 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:53:26 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:53:26 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:53:26 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 1. Apr 12 11:53:26 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:53:26 sounds sudo[6109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volparametriceq.service Apr 12 11:53:26 sounds sudo[6109]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:53:26 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:53:26 sounds sudo[6109]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:26 sounds volumio[956]: info: Alsaloop bridge ok Apr 12 11:53:26 sounds volumio[6111]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:53:26 sounds volumio[6111]: playback outplugin open error: No such file or directory Apr 12 11:53:26 sounds volumio[6111]: Loopback initialization failure. Apr 12 11:53:26 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:53:26 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:53:27 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:53:27 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 2. Apr 12 11:53:27 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:53:27 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:53:27 sounds volumio[6112]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:53:27 sounds volumio[6112]: playback outplugin open error: No such file or directory Apr 12 11:53:27 sounds volumio[6112]: Loopback initialization failure. Apr 12 11:53:27 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:53:27 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:53:27 sounds mpd[6097]: Apr 12 11:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 12 11:53:27 sounds systemd[1]: Started Music Player Daemon. Apr 12 11:53:27 sounds sudo[6065]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:27 sounds sudo[6074]: pam_unix(sudo:session): session closed for user root Apr 12 11:53:27 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:53:27 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 3. Apr 12 11:53:27 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:53:27 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:53:27 sounds volumio[956]: error: MPD error: The expression evaluated to a falsy value: Apr 12 11:53:27 sounds volumio[956]: assert.ok(self.idling) Apr 12 11:53:27 sounds volumio[956]: error: The expression evaluated to a falsy value: Apr 12 11:53:27 sounds volumio[956]: assert.ok(self.idling) Apr 12 11:53:27 sounds volumio[6116]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:53:27 sounds volumio[6116]: playback outplugin open error: No such file or directory Apr 12 11:53:27 sounds volumio[6116]: Loopback initialization failure. Apr 12 11:53:27 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:53:27 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:53:28 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:53:28 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 4. Apr 12 11:53:28 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:53:28 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:53:28 sounds volumio[6124]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:53:28 sounds volumio[6124]: playback outplugin open error: No such file or directory Apr 12 11:53:28 sounds volumio[6124]: Loopback initialization failure. Apr 12 11:53:28 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:53:28 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:53:28 sounds volumio[956]: error: updateQueue error: null Apr 12 11:53:28 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:53:28 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 5. Apr 12 11:53:28 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:53:28 sounds systemd[1]: volparametriceq.service: Start request repeated too quickly. Apr 12 11:53:28 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:53:28 sounds systemd[1]: Failed to start alsaloop for volparametric equalizer. Apr 12 11:53:34 sounds kernel: hwmon hwmon1: Voltage normalised Apr 12 11:53:36 sounds kernel: hwmon hwmon1: Undervoltage detected! Apr 12 11:53:42 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 11:53:42 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 11:53:46 sounds volumio[956]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 11:53:46 sounds kernel: hwmon hwmon1: Voltage normalised Apr 12 11:53:56 sounds volumio[956]: info: CALLMETHOD: audio_interface volparametriceq saveAdvanced [object Object] Apr 12 11:53:56 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: volparametriceq , saveAdvanced Apr 12 11:53:56 sounds volumio[956]: info: New bands of equalizer have been set Apr 12 11:53:56 sounds volumio[956]: info: Ui has changed, forcing UI Reload Apr 12 11:53:56 sounds volumio[956]: info: CoreCommandRouter::Reload Ui Apr 12 11:53:56 sounds volumio[956]: info: UIconfig.json file written Apr 12 11:53:59 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 11:53:59 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 11:54:03 sounds volumio[956]: info: Enabling plugin volstereo2mono Apr 12 11:54:03 sounds volumio[956]: info: Loading plugin "volstereo2mono"... Apr 12 11:54:03 sounds volumio[956]: info: PLUGIN START: volstereo2mono Apr 12 11:54:03 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:03 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:03 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:03 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:03 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:03 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:03 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:03 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:03 sounds volumio[956]: info: Volstereo2mono Started Apr 12 11:54:03 sounds volumio[956]: info: Done. Apr 12 11:54:03 sounds sudo[6145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Apr 12 11:54:03 sounds sudo[6145]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:03 sounds volumio[956]: info: asound.conf file written Apr 12 11:54:03 sounds sudo[6145]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:03 sounds sudo[6148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/asoundrc /etc/asound.conf Apr 12 11:54:03 sounds sudo[6148]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:04 sounds sudo[6148]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:04 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:04 sounds volumio[956]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Apr 12 11:54:04 sounds volumio[956]: Hardware is initialized using a generic method Apr 12 11:54:04 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:04 sounds volumio[956]: info: snd_aloop loaded Apr 12 11:54:04 sounds volumio[956]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 11:54:05 sounds kernel: hwmon hwmon1: Undervoltage detected! Apr 12 11:54:06 sounds volumio[956]: info: CALLMETHOD: audio_interface volstereo2mono savevolstereo2mono [object Object] Apr 12 11:54:06 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: volstereo2mono , savevolstereo2mono Apr 12 11:54:06 sounds volumio[956]: info: asound.conf file written Apr 12 11:54:06 sounds sudo[6154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volstereo2mono.service Apr 12 11:54:06 sounds sudo[6154]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:06 sounds sudo[6157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/asoundrc /etc/asound.conf Apr 12 11:54:06 sounds sudo[6157]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:06 sounds sudo[6157]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:06 sounds systemd[1]: Started alsaloop for volstereo2mono. Apr 12 11:54:06 sounds sudo[6154]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:06 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:06 sounds volumio[956]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Apr 12 11:54:06 sounds volumio[956]: Hardware is initialized using a generic method Apr 12 11:54:06 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:08 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC Apr 12 11:54:08 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:08 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 12 11:54:08 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 11:54:08 sounds volumio[956]: warn: Unable to locate the device Headphones through volparametriceq plugin through stereo2mono plugin a reboot may be required. Apr 12 11:54:08 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 11:54:08 sounds volumio[956]: info: Output is Loopback, do not update Mixer Apr 12 11:54:08 sounds volumio[956]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 11:54:08 sounds volumio[956]: info: Preparing to generate the ALSA configuration file Apr 12 11:54:08 sounds sudo[6167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Apr 12 11:54:08 sounds sudo[6167]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:08 sounds sudo[6167]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:08 sounds volumio[956]: info: No Overlays Loaded Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 11:54:09 sounds volumio[956]: info: Asound.conf file written Apr 12 11:54:09 sounds sudo[6174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 12 11:54:09 sounds sudo[6174]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:09 sounds sudo[6174]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:09 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:09 sounds volumio[956]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Apr 12 11:54:09 sounds volumio[956]: Hardware is initialized using a generic method Apr 12 11:54:09 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:09 sounds volumio[956]: info: Output device has changed, restarting MPD Apr 12 11:54:09 sounds sudo[6179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 11:54:09 sounds volumio[956]: info: Output device has changed, restarting Shairport Sync Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:09 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:09 sounds sudo[6179]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:09 sounds sudo[6179]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:09 sounds sudo[6182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 11:54:09 sounds sudo[6182]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:10 sounds systemd[1]: Stopping Music Player Daemon... Apr 12 11:54:10 sounds volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 11:54:10 sounds systemd[1]: mpd.service: Succeeded. Apr 12 11:54:10 sounds systemd[1]: Stopped Music Player Daemon. Apr 12 11:54:10 sounds volumio[956]: info: Output device has changed, restarting MPD Apr 12 11:54:10 sounds systemd[1]: Starting Music Player Daemon... Apr 12 11:54:10 sounds sudo[6192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 11:54:10 sounds sudo[6192]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:10 sounds volumio[956]: info: Output device has changed, restarting Shairport Sync Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:10 sounds sudo[6192]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:10 sounds sudo[6195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 11:54:10 sounds sudo[6195]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:10 sounds systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 12 11:54:10 sounds systemd[1]: mpd.service: Succeeded. Apr 12 11:54:10 sounds systemd[1]: Stopped Music Player Daemon. Apr 12 11:54:10 sounds volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 11:54:10 sounds systemd[1]: Starting Music Player Daemon... Apr 12 11:54:10 sounds volumio[956]: info: MPD Permissions set Apr 12 11:54:10 sounds volumio[956]: info: MPD Permissions set Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:10 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:11 sounds volumio[956]: info: Starting Shairport Sync Apr 12 11:54:11 sounds volumio[956]: info: Starting Shairport Sync Apr 12 11:54:11 sounds sudo[6213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 11:54:11 sounds sudo[6213]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:11 sounds sudo[6215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 11:54:11 sounds sudo[6215]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:11 sounds systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 12 11:54:11 sounds systemd[1]: shairport-sync.service: Succeeded. Apr 12 11:54:11 sounds systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:11 sounds systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:11 sounds sudo[6213]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:11 sounds volumio[956]: info: Shairport-Sync Started Apr 12 11:54:11 sounds systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 12 11:54:11 sounds systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 12 11:54:11 sounds systemd[1]: shairport-sync.service: Succeeded. Apr 12 11:54:11 sounds systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:11 sounds systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:11 sounds sudo[6215]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:11 sounds volumio[956]: info: Shairport-Sync Started Apr 12 11:54:14 sounds mpd[6200]: Apr 12 11:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 12 11:54:14 sounds systemd[1]: Started Music Player Daemon. Apr 12 11:54:14 sounds sudo[6182]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:14 sounds sudo[6195]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:14 sounds volumio[956]: error: MPD error: The expression evaluated to a falsy value: Apr 12 11:54:14 sounds volumio[956]: assert.ok(self.idling) Apr 12 11:54:14 sounds volumio[956]: error: The expression evaluated to a falsy value: Apr 12 11:54:14 sounds volumio[956]: assert.ok(self.idling) Apr 12 11:54:14 sounds volumio[956]: error: updateQueue error: null Apr 12 11:54:15 sounds volumio[956]: { Apr 12 11:54:15 sounds volumio[956]: device: '1', Apr 12 11:54:15 sounds volumio[956]: name: 'Headphones', Apr 12 11:54:15 sounds volumio[956]: mixer: 'PCM', Apr 12 11:54:15 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:54:15 sounds volumio[956]: maxvolume: '100', Apr 12 11:54:15 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:54:15 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:54:15 sounds volumio[956]: volumesteps: '1' Apr 12 11:54:15 sounds volumio[956]: } Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:54:15 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:54:15 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:54:15 sounds volumio[956]: { Apr 12 11:54:15 sounds volumio[956]: device: 'Loopback', Apr 12 11:54:15 sounds volumio[956]: name: 'Headphones through volparametriceq plugin', Apr 12 11:54:15 sounds volumio[956]: mixer: 'PCM', Apr 12 11:54:15 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:54:15 sounds volumio[956]: maxvolume: '100', Apr 12 11:54:15 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:54:15 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:54:15 sounds volumio[956]: volumesteps: '1' Apr 12 11:54:15 sounds volumio[956]: } Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:54:15 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: Loopback Name: Headphones through volparametriceq plugin Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:54:15 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:54:15 sounds volumio[956]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'PCM',0 Apr 12 11:54:15 sounds volumio[956]: info: VolumeController:: Volume=86 Mute =false Apr 12 11:54:15 sounds volumio[956]: info: CoreStateMachine::pushState Apr 12 11:54:15 sounds volumio[956]: info: CorePlayQueue::getTrack 0 Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::volumioPushState Apr 12 11:54:15 sounds volumio[956]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Apr 12 11:54:15 sounds volumio[956]: info: VolumeController:: Volume=undefined Mute =false Apr 12 11:54:15 sounds volumio[956]: info: CoreStateMachine::pushState Apr 12 11:54:15 sounds volumio[956]: info: CorePlayQueue::getTrack 0 Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::volumioPushState Apr 12 11:54:15 sounds volumio[956]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Apr 12 11:54:15 sounds volumio[956]: { Apr 12 11:54:15 sounds volumio[956]: device: '1', Apr 12 11:54:15 sounds volumio[956]: name: 'Headphones', Apr 12 11:54:15 sounds volumio[956]: mixer: 'PCM', Apr 12 11:54:15 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:54:15 sounds volumio[956]: maxvolume: '100', Apr 12 11:54:15 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:54:15 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:54:15 sounds volumio[956]: volumesteps: '1' Apr 12 11:54:15 sounds volumio[956]: } Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:54:15 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:54:15 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:54:15 sounds volumio[956]: { Apr 12 11:54:15 sounds volumio[956]: device: 'Loopback', Apr 12 11:54:15 sounds volumio[956]: name: 'Headphones through volparametriceq plugin', Apr 12 11:54:15 sounds volumio[956]: mixer: 'PCM', Apr 12 11:54:15 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:54:15 sounds volumio[956]: maxvolume: '100', Apr 12 11:54:15 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:54:15 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:54:15 sounds volumio[956]: volumesteps: '1' Apr 12 11:54:15 sounds volumio[956]: } Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:54:15 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: Loopback Name: Headphones through volparametriceq plugin Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:54:15 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:54:15 sounds volumio[956]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'PCM',0 Apr 12 11:54:15 sounds volumio[956]: info: VolumeController:: Volume=86 Mute =false Apr 12 11:54:15 sounds volumio[956]: info: CoreStateMachine::pushState Apr 12 11:54:15 sounds volumio[956]: info: CorePlayQueue::getTrack 0 Apr 12 11:54:15 sounds volumio[956]: info: CoreCommandRouter::volumioPushState Apr 12 11:54:16 sounds volumio[956]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Apr 12 11:54:16 sounds volumio[956]: info: VolumeController:: Volume=undefined Mute =false Apr 12 11:54:16 sounds volumio[956]: info: CoreStateMachine::pushState Apr 12 11:54:16 sounds volumio[956]: info: CorePlayQueue::getTrack 0 Apr 12 11:54:16 sounds volumio[956]: info: CoreCommandRouter::volumioPushState Apr 12 11:54:16 sounds volumio[956]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Apr 12 11:54:16 sounds sudo[6235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volparametriceq.service Apr 12 11:54:16 sounds sudo[6235]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:16 sounds sudo[6237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volstereo2mono.service Apr 12 11:54:16 sounds sudo[6237]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:17 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:54:17 sounds sudo[6237]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:17 sounds sudo[6235]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:17 sounds volumio[956]: info: Alsaloop bridge ok Apr 12 11:54:17 sounds volumio[956]: info: Alsaloop bridge ok Apr 12 11:54:17 sounds volumio[6240]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:54:17 sounds volumio[6240]: playback outplugin open error: No such file or directory Apr 12 11:54:17 sounds volumio[6240]: Loopback initialization failure. Apr 12 11:54:17 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:54:17 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:54:17 sounds sudo[6242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volparametriceq.service Apr 12 11:54:17 sounds sudo[6242]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:17 sounds sudo[6244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volstereo2mono.service Apr 12 11:54:17 sounds sudo[6244]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:17 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:54:17 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 1. Apr 12 11:54:17 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:54:17 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:54:17 sounds sudo[6242]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:17 sounds volumio[956]: info: Alsaloop bridge ok Apr 12 11:54:17 sounds sudo[6244]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:17 sounds volumio[956]: info: Alsaloop bridge ok Apr 12 11:54:17 sounds volumio[6248]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:54:17 sounds volumio[6248]: playback outplugin open error: No such file or directory Apr 12 11:54:17 sounds volumio[6248]: Loopback initialization failure. Apr 12 11:54:17 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:54:17 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:54:17 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:54:17 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 2. Apr 12 11:54:17 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:54:17 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:54:18 sounds volumio[6249]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:54:18 sounds volumio[6249]: playback outplugin open error: No such file or directory Apr 12 11:54:18 sounds volumio[6249]: Loopback initialization failure. Apr 12 11:54:18 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:54:18 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:54:18 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:54:18 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 3. Apr 12 11:54:18 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:54:18 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:54:18 sounds volumio[6256]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:54:18 sounds volumio[6256]: playback outplugin open error: No such file or directory Apr 12 11:54:18 sounds volumio[6256]: Loopback initialization failure. Apr 12 11:54:18 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:54:18 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:54:18 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:54:18 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 4. Apr 12 11:54:18 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:54:18 sounds systemd[1]: Started alsaloop for volparametric equalizer. Apr 12 11:54:18 sounds volumio[956]: info: Enabling plugin peppyMeter Apr 12 11:54:18 sounds volumio[956]: info: Loading plugin "peppyMeter"... Apr 12 11:54:18 sounds volumio[956]: error: !!!! WARNING !!!! Apr 12 11:54:18 sounds volumio[956]: error: The plugin user_interface/peppyMeter failed to load, setting it to stopped. Error: Error: Cannot find module 'fs-extra' Apr 12 11:54:18 sounds volumio[956]: Require stack: Apr 12 11:54:18 sounds volumio[956]: - /data/plugins/user_interface/peppyMeter/index.js Apr 12 11:54:18 sounds volumio[956]: - /volumio/app/pluginmanager.js Apr 12 11:54:18 sounds volumio[956]: - /volumio/app/index.js Apr 12 11:54:18 sounds volumio[956]: - /volumio/index.js Apr 12 11:54:18 sounds volumio[956]: error: Stack trace: Error: Cannot find module 'fs-extra' Apr 12 11:54:18 sounds volumio[956]: Require stack: Apr 12 11:54:18 sounds volumio[956]: - /data/plugins/user_interface/peppyMeter/index.js Apr 12 11:54:18 sounds volumio[956]: - /volumio/app/pluginmanager.js Apr 12 11:54:18 sounds volumio[956]: - /volumio/app/index.js Apr 12 11:54:18 sounds volumio[956]: - /volumio/index.js Apr 12 11:54:18 sounds volumio[956]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15) Apr 12 11:54:18 sounds volumio[956]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Apr 12 11:54:18 sounds volumio[956]: at Module.require (internal/modules/cjs/loader.js:952:19) Apr 12 11:54:18 sounds volumio[956]: at require (internal/modules/cjs/helpers.js:88:18) Apr 12 11:54:18 sounds volumio[956]: at Object. (/data/plugins/user_interface/peppyMeter/index.js:3:10) Apr 12 11:54:18 sounds volumio[956]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Apr 12 11:54:18 sounds volumio[956]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Apr 12 11:54:18 sounds volumio[956]: at Module.load (internal/modules/cjs/loader.js:928:32) Apr 12 11:54:18 sounds volumio[956]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Apr 12 11:54:18 sounds volumio[956]: at Module.require (internal/modules/cjs/loader.js:952:19) Apr 12 11:54:18 sounds volumio[956]: at require (internal/modules/cjs/helpers.js:88:18) Apr 12 11:54:18 sounds volumio[956]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Apr 12 11:54:18 sounds volumio[956]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 12 11:54:18 sounds volumio[956]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 12 11:54:18 sounds volumio[956]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 12 11:54:18 sounds volumio[956]: error: !!!! WARNING !!!! Apr 12 11:54:18 sounds volumio[956]: info: Preparing to generate the ALSA configuration file Apr 12 11:54:19 sounds volumio[6272]: ALSA lib pcm.c:2565:(snd_pcm_open_noupdate) Unknown PCM outplugin Apr 12 11:54:19 sounds volumio[6272]: playback outplugin open error: No such file or directory Apr 12 11:54:19 sounds volumio[6272]: Loopback initialization failure. Apr 12 11:54:19 sounds systemd[1]: volparametriceq.service: Main process exited, code=exited, status=1/FAILURE Apr 12 11:54:19 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:54:19 sounds volumio[956]: info: The plugin peppyMeter has an ALSA contribution file volumioPeppyalsa.postPeppyalsa.5.conf Apr 12 11:54:19 sounds volumio[956]: info: Reading ALSA contributions from plugins. Apr 12 11:54:19 sounds volumio[956]: info: Asound.conf file written Apr 12 11:54:19 sounds sudo[6277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 12 11:54:19 sounds sudo[6277]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:19 sounds sudo[6277]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:19 sounds systemd[1]: volparametriceq.service: Service RestartSec=100ms expired, scheduling restart. Apr 12 11:54:19 sounds systemd[1]: volparametriceq.service: Scheduled restart job, restart counter is at 5. Apr 12 11:54:19 sounds systemd[1]: Stopped alsaloop for volparametric equalizer. Apr 12 11:54:19 sounds systemd[1]: volparametriceq.service: Start request repeated too quickly. Apr 12 11:54:19 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:54:19 sounds systemd[1]: Failed to start alsaloop for volparametric equalizer. Apr 12 11:54:19 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:19 sounds volumio[956]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Apr 12 11:54:19 sounds volumio[956]: Hardware is initialized using a generic method Apr 12 11:54:19 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:19 sounds volumio[956]: info: Output device has changed, restarting MPD Apr 12 11:54:19 sounds sudo[6282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 11:54:19 sounds sudo[6282]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:19 sounds volumio[956]: info: Output device has changed, restarting Shairport Sync Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:19 sounds sudo[6282]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:19 sounds sudo[6285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 11:54:19 sounds sudo[6285]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:19 sounds systemd[1]: Stopping Music Player Daemon... Apr 12 11:54:19 sounds systemd[1]: mpd.service: Succeeded. Apr 12 11:54:19 sounds systemd[1]: Stopped Music Player Daemon. Apr 12 11:54:19 sounds volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 11:54:19 sounds volumio[956]: info: Done. Apr 12 11:54:19 sounds systemd[1]: Starting Music Player Daemon... Apr 12 11:54:19 sounds volumio[956]: info: MPD Permissions set Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:19 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:20 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:20 sounds volumio[956]: info: Enabling plugin peppyspectrum Apr 12 11:54:20 sounds volumio[956]: info: Loading plugin "peppyspectrum"... Apr 12 11:54:21 sounds volumio[956]: info: Preparing to generate the ALSA configuration file Apr 12 11:54:21 sounds volumio[956]: info: The plugin peppyMeter has an ALSA contribution file volumioPeppyalsa.postPeppyalsa.5.conf Apr 12 11:54:21 sounds volumio[956]: info: The plugin peppyspectrum has an ALSA contribution file volumioPeppyalsasp.postPeppyalsasp.5.conf Apr 12 11:54:21 sounds volumio[956]: info: Reading ALSA contributions from plugins. Apr 12 11:54:21 sounds volumio[956]: info: Starting Shairport Sync Apr 12 11:54:21 sounds volumio[956]: info: Asound.conf file written Apr 12 11:54:21 sounds sudo[6296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 11:54:21 sounds sudo[6296]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:21 sounds systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 12 11:54:21 sounds systemd[1]: shairport-sync.service: Succeeded. Apr 12 11:54:21 sounds systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:21 sounds sudo[6299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 12 11:54:21 sounds sudo[6299]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:21 sounds sudo[6299]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:21 sounds systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:21 sounds sudo[6296]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:22 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:22 sounds volumio[956]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Apr 12 11:54:22 sounds volumio[956]: Hardware is initialized using a generic method Apr 12 11:54:22 sounds volumio[956]: No state is present for card Loopback Apr 12 11:54:22 sounds volumio[956]: info: Output device has changed, restarting MPD Apr 12 11:54:22 sounds sudo[6307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 11:54:22 sounds sudo[6307]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:22 sounds volumio[956]: info: Output device has changed, restarting Shairport Sync Apr 12 11:54:22 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:22 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:22 sounds sudo[6307]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:22 sounds sudo[6310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 11:54:22 sounds sudo[6310]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:22 sounds systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 12 11:54:22 sounds systemd[1]: mpd.service: Succeeded. Apr 12 11:54:22 sounds systemd[1]: Stopped Music Player Daemon. Apr 12 11:54:22 sounds volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 11:54:22 sounds volumio[956]: info: PLUGIN START: peppyspectrum Apr 12 11:54:22 sounds systemd[1]: Starting Music Player Daemon... Apr 12 11:54:22 sounds sudo[6319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=6 pcm_substreams=1 Apr 12 11:54:22 sounds sudo[6319]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:22 sounds sudo[6319]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:22 sounds volumio[956]: info: snd-dummy loaded Apr 12 11:54:22 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 12 11:54:23 sounds volumio[956]: info: Preparing to generate the ALSA configuration file Apr 12 11:54:23 sounds systemd-udevd[6323]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 6' failed with exit code 99. Apr 12 11:54:23 sounds volumio[956]: info: Error: TypeError: Cannot read property 'printToastMessage' of null Apr 12 11:54:23 sounds volumio[956]: info: The plugin peppyMeter has an ALSA contribution file volumioPeppyalsa.postPeppyalsa.5.conf Apr 12 11:54:23 sounds volumio[956]: info: The plugin peppyspectrum has an ALSA contribution file volumioPeppyalsasp.postPeppyalsasp.5.conf Apr 12 11:54:23 sounds volumio[956]: info: Reading ALSA contributions from plugins. Apr 12 11:54:23 sounds volumio[956]: info: added device { Apr 12 11:54:23 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_dummy.0", Apr 12 11:54:23 sounds volumio[956]: "ACTION": "add", Apr 12 11:54:23 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_dummy.0", Apr 12 11:54:23 sounds volumio[956]: "DRIVER": "snd_dummy", Apr 12 11:54:23 sounds volumio[956]: "MODALIAS": "platform:snd_dummy", Apr 12 11:54:23 sounds volumio[956]: "SEQNUM": "1658", Apr 12 11:54:23 sounds volumio[956]: "SUBSYSTEM": "platform", Apr 12 11:54:23 sounds volumio[956]: "USEC_INITIALIZED": "2733765542" Apr 12 11:54:23 sounds volumio[956]: } Apr 12 11:54:23 sounds volumio[956]: info: MPD Permissions set Apr 12 11:54:23 sounds volumio[956]: info: Shairport-Sync Started Apr 12 11:54:23 sounds volumio[956]: info: added device { Apr 12 11:54:23 sounds volumio[956]: "syspath": "/sys/bus/platform/drivers/snd_dummy", Apr 12 11:54:23 sounds volumio[956]: "ACTION": "add", Apr 12 11:54:23 sounds volumio[956]: "DEVPATH": "/bus/platform/drivers/snd_dummy", Apr 12 11:54:23 sounds volumio[956]: "SEQNUM": "1657", Apr 12 11:54:23 sounds volumio[956]: "SUBSYSTEM": "drivers", Apr 12 11:54:23 sounds volumio[956]: "USEC_INITIALIZED": "2733765734" Apr 12 11:54:23 sounds volumio[956]: } Apr 12 11:54:23 sounds volumio[956]: info: added device { Apr 12 11:54:23 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_dummy.0/sound/card6", Apr 12 11:54:23 sounds volumio[956]: "ACTION": "add", Apr 12 11:54:23 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_dummy.0/sound/card6", Apr 12 11:54:23 sounds volumio[956]: "ID_FOR_SEAT": "sound-platform-snd_dummy_0", Apr 12 11:54:23 sounds volumio[956]: "ID_PATH": "platform-snd_dummy.0", Apr 12 11:54:23 sounds volumio[956]: "ID_PATH_TAG": "platform-snd_dummy_0", Apr 12 11:54:23 sounds volumio[956]: "SEQNUM": "1659", Apr 12 11:54:23 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:54:23 sounds volumio[956]: "SYSTEMD_WANTS": "sound.target", Apr 12 11:54:23 sounds volumio[956]: "TAGS": ":systemd:seat:", Apr 12 11:54:23 sounds volumio[956]: "USEC_INITIALIZED": "2733775136" Apr 12 11:54:23 sounds volumio[956]: } Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 11:54:23 sounds volumio[956]: info: added device { Apr 12 11:54:23 sounds volumio[956]: "syspath": "/sys/module/snd_dummy", Apr 12 11:54:23 sounds volumio[956]: "ACTION": "add", Apr 12 11:54:23 sounds volumio[956]: "DEVPATH": "/module/snd_dummy", Apr 12 11:54:23 sounds volumio[956]: "SEQNUM": "1664", Apr 12 11:54:23 sounds volumio[956]: "SUBSYSTEM": "module", Apr 12 11:54:23 sounds volumio[956]: "USEC_INITIALIZED": "2733779768" Apr 12 11:54:23 sounds volumio[956]: } Apr 12 11:54:23 sounds volumio[956]: info: added device { Apr 12 11:54:23 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_dummy.0/sound/card6/pcmC6D0p", Apr 12 11:54:23 sounds volumio[956]: "ACTION": "add", Apr 12 11:54:23 sounds volumio[956]: "DEVNAME": "/dev/snd/pcmC6D0p", Apr 12 11:54:23 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_dummy.0/sound/card6/pcmC6D0p", Apr 12 11:54:23 sounds volumio[956]: "DEVTYPE": "pcm", Apr 12 11:54:23 sounds volumio[956]: "MAJOR": "116", Apr 12 11:54:23 sounds volumio[956]: "MINOR": "12", Apr 12 11:54:23 sounds volumio[956]: "SEQNUM": "1660", Apr 12 11:54:23 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:54:23 sounds volumio[956]: "TAGS": ":uaccess:", Apr 12 11:54:23 sounds volumio[956]: "USEC_INITIALIZED": "2733805224" Apr 12 11:54:23 sounds volumio[956]: } Apr 12 11:54:23 sounds volumio[956]: info: added device { Apr 12 11:54:23 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_dummy.0/sound/card6/pcmC6D0c", Apr 12 11:54:23 sounds volumio[956]: "ACTION": "add", Apr 12 11:54:23 sounds volumio[956]: "DEVNAME": "/dev/snd/pcmC6D0c", Apr 12 11:54:23 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_dummy.0/sound/card6/pcmC6D0c", Apr 12 11:54:23 sounds volumio[956]: "DEVTYPE": "pcm", Apr 12 11:54:23 sounds volumio[956]: "MAJOR": "116", Apr 12 11:54:23 sounds volumio[956]: "MINOR": "13", Apr 12 11:54:23 sounds volumio[956]: "SEQNUM": "1661", Apr 12 11:54:23 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:54:23 sounds volumio[956]: "TAGS": ":uaccess:", Apr 12 11:54:23 sounds volumio[956]: "USEC_INITIALIZED": "2733805677" Apr 12 11:54:23 sounds volumio[956]: } Apr 12 11:54:23 sounds volumio[956]: info: Starting Shairport Sync Apr 12 11:54:23 sounds volumio[956]: info: added device { Apr 12 11:54:23 sounds volumio[956]: "syspath": "/sys/devices/platform/snd_dummy.0/sound/card6/controlC6", Apr 12 11:54:23 sounds volumio[956]: "ACTION": "add", Apr 12 11:54:23 sounds volumio[956]: "DEVLINKS": "/dev/snd/by-path/platform-snd_dummy.0", Apr 12 11:54:23 sounds volumio[956]: "DEVNAME": "/dev/snd/controlC6", Apr 12 11:54:23 sounds volumio[956]: "DEVPATH": "/devices/platform/snd_dummy.0/sound/card6/controlC6", Apr 12 11:54:23 sounds volumio[956]: "ID_PATH": "platform-snd_dummy.0", Apr 12 11:54:23 sounds volumio[956]: "ID_PATH_TAG": "platform-snd_dummy_0", Apr 12 11:54:23 sounds volumio[956]: "MAJOR": "116", Apr 12 11:54:23 sounds volumio[956]: "MINOR": "14", Apr 12 11:54:23 sounds volumio[956]: "SEQNUM": "1662", Apr 12 11:54:23 sounds volumio[956]: "SUBSYSTEM": "sound", Apr 12 11:54:23 sounds volumio[956]: "TAGS": ":uaccess:", Apr 12 11:54:23 sounds volumio[956]: "USEC_INITIALIZED": "2733820924" Apr 12 11:54:23 sounds volumio[956]: } Apr 12 11:54:23 sounds volumio[956]: info: Asound.conf file unchanged, so no further update is needed Apr 12 11:54:23 sounds volumio[956]: info: Output device has changed, restarting MPD Apr 12 11:54:23 sounds sudo[6330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 11:54:23 sounds sudo[6330]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:23 sounds systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 12 11:54:23 sounds systemd[1]: shairport-sync.service: Succeeded. Apr 12 11:54:23 sounds systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:23 sounds sudo[6333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 11:54:23 sounds systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:23 sounds volumio[956]: info: Output device has changed, restarting Shairport Sync Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:23 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:23 sounds sudo[6330]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:23 sounds sudo[6333]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:24 sounds sudo[6333]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:24 sounds sudo[6336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 11:54:24 sounds sudo[6336]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:24 sounds systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 12 11:54:24 sounds systemd[1]: mpd.service: Succeeded. Apr 12 11:54:24 sounds systemd[1]: Stopped Music Player Daemon. Apr 12 11:54:24 sounds volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 11:54:24 sounds systemd[1]: Starting Music Player Daemon... Apr 12 11:54:24 sounds volumio[956]: info: MPD Permissions set Apr 12 11:54:24 sounds volumio[956]: info: Shairport-Sync Started Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 11:54:24 sounds volumio[956]: info: Starting Shairport Sync Apr 12 11:54:24 sounds sudo[6353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 11:54:24 sounds sudo[6353]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:24 sounds systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 12 11:54:24 sounds systemd[1]: shairport-sync.service: Succeeded. Apr 12 11:54:24 sounds systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:24 sounds volumio[956]: { Apr 12 11:54:24 sounds volumio[956]: device: '1', Apr 12 11:54:24 sounds volumio[956]: name: 'Headphones', Apr 12 11:54:24 sounds volumio[956]: mixer: 'PCM', Apr 12 11:54:24 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:54:24 sounds volumio[956]: maxvolume: '100', Apr 12 11:54:24 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:54:24 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:54:24 sounds volumio[956]: volumesteps: '1' Apr 12 11:54:24 sounds volumio[956]: } Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:54:24 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:54:24 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:54:24 sounds systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 12 11:54:24 sounds volumio[956]: { Apr 12 11:54:24 sounds volumio[956]: device: 'Loopback', Apr 12 11:54:24 sounds volumio[956]: name: 'Headphones through volparametriceq plugin', Apr 12 11:54:24 sounds volumio[956]: mixer: 'PCM', Apr 12 11:54:24 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:54:24 sounds volumio[956]: maxvolume: '100', Apr 12 11:54:24 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:54:24 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:54:24 sounds volumio[956]: volumesteps: '1' Apr 12 11:54:24 sounds volumio[956]: } Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:54:24 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: Loopback Name: Headphones through volparametriceq plugin Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:54:24 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:54:24 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:54:24 sounds sudo[6353]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:25 sounds volumio[956]: info: Shairport-Sync Started Apr 12 11:54:25 sounds volumio[956]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'PCM',0 Apr 12 11:54:25 sounds volumio[956]: info: VolumeController:: Volume=86 Mute =false Apr 12 11:54:25 sounds volumio[956]: info: CoreStateMachine::pushState Apr 12 11:54:25 sounds volumio[956]: info: CorePlayQueue::getTrack 0 Apr 12 11:54:25 sounds volumio[956]: info: CoreCommandRouter::volumioPushState Apr 12 11:54:25 sounds volumio[956]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Apr 12 11:54:25 sounds volumio[956]: info: VolumeController:: Volume=undefined Mute =false Apr 12 11:54:25 sounds volumio[956]: info: CoreStateMachine::pushState Apr 12 11:54:25 sounds volumio[956]: info: CorePlayQueue::getTrack 0 Apr 12 11:54:25 sounds volumio[956]: info: CoreCommandRouter::volumioPushState Apr 12 11:54:25 sounds volumio[956]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Apr 12 11:54:25 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 11:54:25 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 11:54:26 sounds sudo[6363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volparametriceq.service Apr 12 11:54:26 sounds sudo[6363]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:26 sounds sudo[6365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volstereo2mono.service Apr 12 11:54:26 sounds sudo[6365]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 11:54:26 sounds systemd[1]: volparametriceq.service: Start request repeated too quickly. Apr 12 11:54:26 sounds sudo[6365]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:26 sounds systemd[1]: volparametriceq.service: Failed with result 'exit-code'. Apr 12 11:54:26 sounds volumio[956]: info: Alsaloop bridge ok Apr 12 11:54:26 sounds systemd[1]: Failed to start alsaloop for volparametric equalizer. Apr 12 11:54:26 sounds sudo[6363]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:26 sounds volumio[956]: info: failed to bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start volparametriceq.service Apr 12 11:54:26 sounds volumio[956]: Job for volparametriceq.service failed because the control process exited with error code. Apr 12 11:54:26 sounds volumio[956]: See "systemctl status volparametriceq.service" and "journalctl -xe" for details. Apr 12 11:54:27 sounds volumio[956]: { Apr 12 11:54:27 sounds volumio[956]: device: '1', Apr 12 11:54:27 sounds volumio[956]: name: 'Headphones', Apr 12 11:54:27 sounds volumio[956]: mixer: 'PCM', Apr 12 11:54:27 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:54:27 sounds volumio[956]: maxvolume: '100', Apr 12 11:54:27 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:54:27 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:54:27 sounds volumio[956]: volumesteps: '1' Apr 12 11:54:27 sounds volumio[956]: } Apr 12 11:54:27 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:54:27 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: 1 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:54:27 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:54:27 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:54:27 sounds volumio[956]: { Apr 12 11:54:27 sounds volumio[956]: device: 'Loopback', Apr 12 11:54:27 sounds volumio[956]: name: 'Headphones through volparametriceq plugin', Apr 12 11:54:27 sounds volumio[956]: mixer: 'PCM', Apr 12 11:54:27 sounds volumio[956]: mixertype: 'Hardware', Apr 12 11:54:27 sounds volumio[956]: maxvolume: '100', Apr 12 11:54:27 sounds volumio[956]: volumecurve: 'logarithmic', Apr 12 11:54:27 sounds volumio[956]: volumestart: 'disabled', Apr 12 11:54:27 sounds volumio[956]: volumesteps: '1' Apr 12 11:54:27 sounds volumio[956]: } Apr 12 11:54:27 sounds volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 11:54:27 sounds volumio[956]: info: Updating Volume Controller Parameters: Device: Loopback Name: Headphones through volparametriceq plugin Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 11:54:27 sounds volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 11:54:27 sounds volumio[956]: info: Disabling external Volume Control Apr 12 11:54:28 sounds mpd[6344]: Apr 12 11:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 12 11:54:28 sounds systemd[1]: Started Music Player Daemon. Apr 12 11:54:28 sounds sudo[6285]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:28 sounds sudo[6336]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:28 sounds sudo[6310]: pam_unix(sudo:session): session closed for user root Apr 12 11:54:28 sounds volumio[956]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 11:54:28 sounds volumio[956]: TypeError: Cannot read property 'printToastMessage' of null Apr 12 11:54:28 sounds volumio[956]: at /volumio/app/index.js:1194:32 Apr 12 11:54:28 sounds volumio[956]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Apr 12 11:54:28 sounds volumio[956]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Apr 12 11:54:28 sounds volumio[956]: at CoreCommandRouter.pushToastMessage (/volumio/app/index.js:1192:13) Apr 12 11:54:28 sounds volumio[956]: at /volumio/app/plugins/music_service/mpd/index.js:790:30 Apr 12 11:54:28 sounds volumio[956]: at /volumio/app/plugins/music_service/mpd/index.js:934:9 Apr 12 11:54:28 sounds volumio[956]: at ChildProcess.exithandler (child_process.js:299:7) Apr 12 11:54:28 sounds volumio[956]: at ChildProcess.emit (events.js:315:20) Apr 12 11:54:28 sounds volumio[956]: at maybeClose (internal/child_process.js:1048:16) Apr 12 11:54:28 sounds volumio[956]: at Socket. (internal/child_process.js:439:11) Apr 12 11:54:28 sounds volumio[956]: at Socket.emit (events.js:315:20) Apr 12 11:54:28 sounds volumio[956]: at Pipe. (net.js:673:12) Apr 12 11:54:28 sounds volumio[956]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 11:54:30 sounds sudo[6393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-12 11:53 Apr 12 11:54:30 sounds sudo[6393]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"