-- Logs begin at Thu 2019-02-14 11:12:03 CET, end at Wed 2024-04-17 19:49:25 CEST. -- Apr 17 19:48:23 volumio volumio[10857]: info: Checking if install.sh is present Apr 17 19:48:23 volumio volumio[10857]: info: Executing install.sh Apr 17 19:48:25 volumio sudo[11463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh Apr 17 19:48:25 volumio sudo[11463]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 19:48:27 volumio systemd[1]: Reloading. Apr 17 19:48:33 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 17 19:48:35 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Apr 17 19:48:35 volumio systemd[1]: serial-getty@ttyAMA0.service: Current command vanished from the unit file, execution of the command list won't be resumed. Apr 17 19:48:36 volumio volumio[10857]: info: Dowloading daemon Apr 17 19:48:44 volumio volumio[10857]: info: Creating Start Script Apr 17 19:48:44 volumio systemd[1]: Reloading. Apr 17 19:48:47 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Apr 17 19:48:49 volumio sudo[11463]: pam_unix(sudo:session): session closed for user root Apr 17 19:48:49 volumio volumio[10857]: Plugin install end detected on script Apr 17 19:48:49 volumio volumio[10857]: info: Install script completed Apr 17 19:48:49 volumio volumio[10857]: info: Adding reference to registry Apr 17 19:48:49 volumio volumio[10857]: info: Done installing plugin. Apr 17 19:48:49 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 17 19:48:49 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 17 19:48:49 volumio volumio[10857]: info: Folder /tmp/plugins removed Apr 17 19:48:49 volumio volumio[10857]: info: Folder /tmp/downloaded_plugin.zip removed Apr 17 19:48:49 volumio volumio[10857]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 19:48:49 volumio volumio[10857]: info: Folder /data/temp removed Apr 17 19:48:51 volumio volumio[10857]: info: FusionDsp - >>>>>>>>>>>>> armv6l Apr 17 19:48:51 volumio volumio[10857]: info: FusionDsp - Convolution not available for cpu armv6l ! Apr 17 19:48:54 volumio volumio[10857]: info: Enabling plugin spop Apr 17 19:48:54 volumio volumio[10857]: info: Loading plugin "spop"... Apr 17 19:49:00 volumio volumio[10857]: info: PLUGIN START: spop Apr 17 19:49:00 volumio volumio[10857]: info: Creating Spotify config file Apr 17 19:49:00 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:00 volumio volumio[10857]: info: Done. Apr 17 19:49:01 volumio volumio[10857]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 17 19:49:01 volumio volumio[10857]: info: Spotify config file written Apr 17 19:49:01 volumio sudo[11511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 17 19:49:01 volumio sudo[11511]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 19:49:01 volumio systemd[1]: Started go-librespot Daemon. Apr 17 19:49:01 volumio go-librespot[11513]: Librespot-go daemon starting... Apr 17 19:49:01 volumio sudo[11511]: pam_unix(sudo:session): session closed for user root Apr 17 19:49:02 volumio go-librespot[11513]: time="2024-04-17T19:49:02+02:00" level=info msg="generated new device id: 7f446a2dd9767c8807cd19af66b2e98316ba2af7" Apr 17 19:49:05 volumio go-librespot[11513]: time="2024-04-17T19:49:05+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 17 19:49:05 volumio go-librespot[11513]: time="2024-04-17T19:49:05+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 17 19:49:05 volumio go-librespot[11513]: time="2024-04-17T19:49:05+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Apr 17 19:49:05 volumio go-librespot[11513]: time="2024-04-17T19:49:05+02:00" level=debug msg="zeroconf server listening on port 37533" Apr 17 19:49:06 volumio volumio[10857]: info: FusionDsp - >>>>>>>>>>>>> armv6l Apr 17 19:49:06 volumio volumio[10857]: info: FusionDsp - Convolution not available for cpu armv6l ! Apr 17 19:49:07 volumio volumio[10857]: info: Starting Uninstall of plugin audio_interface - fusiondsp Apr 17 19:49:07 volumio volumio[10857]: info: Uninstalling plugin fusiondsp Apr 17 19:49:07 volumio volumio[10857]: info: FusionDsp - Stopping FusionDsp service Apr 17 19:49:07 volumio volumio[10857]: info: camilladsp stopping service pid 11231... Apr 17 19:49:07 volumio volumio[10857]: info: camilladsp service terminated, instance 1 Apr 17 19:49:07 volumio volumio[10857]: info: Disabling plugin fusiondsp Apr 17 19:49:07 volumio volumio[10857]: info: Preparing to generate the ALSA configuration file Apr 17 19:49:07 volumio sudo[11523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Apr 17 19:49:07 volumio sudo[11523]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 19:49:07 volumio systemd[1]: Stopping FusionDsp Daemon... Apr 17 19:49:07 volumio volumio[7965]: Backend configuration: Apr 17 19:49:07 volumio volumio[7965]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Apr 17 19:49:07 volumio volumio[7965]: active_config_txt: null Apr 17 19:49:07 volumio volumio[7965]: camilla_host: 127.0.0.1 Apr 17 19:49:07 volumio volumio[7965]: camilla_port: 9876 Apr 17 19:49:07 volumio volumio[7965]: coeff_dir: /data/INTERNAL/FusionDsp/filters Apr 17 19:49:07 volumio volumio[7965]: config_dir: /data/configuration/audio_interface/fusiondsp Apr 17 19:49:07 volumio volumio[7965]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Apr 17 19:49:07 volumio volumio[7965]: log_file: /tmp/camilladsp.log Apr 17 19:49:07 volumio volumio[7965]: on_get_active_config: null Apr 17 19:49:07 volumio volumio[7965]: on_set_active_config: null Apr 17 19:49:07 volumio volumio[7965]: port: 5011 Apr 17 19:49:07 volumio volumio[7965]: supported_capture_types: null Apr 17 19:49:07 volumio volumio[7965]: supported_playback_types: null Apr 17 19:49:07 volumio volumio[7965]: update_config_symlink: false Apr 17 19:49:07 volumio volumio[7965]: update_config_txt: false Apr 17 19:49:07 volumio volumio[7965]: ======== Running on http://0.0.0.0:5011 ======== Apr 17 19:49:07 volumio volumio[7965]: (Press CTRL+C to quit) Apr 17 19:49:08 volumio volumio[10857]: info: Asound.conf file written Apr 17 19:49:08 volumio sudo[11526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 17 19:49:08 volumio sudo[11526]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 19:49:08 volumio sudo[11526]: pam_unix(sudo:session): session closed for user root Apr 17 19:49:09 volumio systemd[1]: fusiondsp.service: Succeeded. Apr 17 19:49:09 volumio volumio[10857]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy Apr 17 19:49:09 volumio volumio[10857]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy Apr 17 19:49:09 volumio volumio[10857]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy Apr 17 19:49:09 volumio systemd[1]: Stopped FusionDsp Daemon. Apr 17 19:49:09 volumio volumio[10857]: info: Output device has changed, restarting MPD Apr 17 19:49:09 volumio sudo[11523]: pam_unix(sudo:session): session closed for user root Apr 17 19:49:09 volumio volumio[10857]: info: Output device has changed, restarting Shairport Sync Apr 17 19:49:09 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:09 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 19:49:09 volumio sudo[11531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 17 19:49:09 volumio sudo[11531]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 19:49:09 volumio sudo[11531]: pam_unix(sudo:session): session closed for user root Apr 17 19:49:09 volumio sudo[11533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 17 19:49:09 volumio sudo[11533]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 19:49:10 volumio systemd[1]: Stopping Music Player Daemon... Apr 17 19:49:10 volumio volumio[10857]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 17 19:49:10 volumio systemd[1]: mpd.service: Succeeded. Apr 17 19:49:10 volumio systemd[1]: Stopped Music Player Daemon. Apr 17 19:49:10 volumio volumio[10857]: info: Checking if uninstall.sh is present Apr 17 19:49:10 volumio systemd[1]: Starting Music Player Daemon... Apr 17 19:49:10 volumio volumio[10857]: info: Executing uninstall.sh Apr 17 19:49:11 volumio volumio[10857]: info: MPD Permissions set Apr 17 19:49:11 volumio volumio[10857]: info: FusionDsp - Reporting Fusion DSP Disabled Apr 17 19:49:11 volumio volumio[10857]: info: Removing fusiondspeq DSP Signal Path Element Apr 17 19:49:11 volumio volumio[10857]: info: go-librespot daemon successfully initialized Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 17 19:49:11 volumio volumio[10857]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 17 19:49:12 volumio sudo[11543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Apr 17 19:49:12 volumio volumio[10857]: info: Starting Shairport Sync Apr 17 19:49:12 volumio sudo[11543]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 19:49:12 volumio sudo[11551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 17 19:49:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 17 19:49:12 volumio sudo[11551]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 19:49:16 volumio volumio[10857]: info: Shairport-Sync Started Apr 17 19:49:16 volumio volumio[10857]: info: Initializing connection to go-librespot Websocket Apr 17 19:49:16 volumio volumio[10857]: info: Connection to go-librespot Websocket established Apr 17 19:49:16 volumio volumio[10857]: info: Starting Uninstall of plugin audio_interface - fusiondsp Apr 17 19:49:16 volumio volumio[10857]: info: Uninstalling plugin fusiondsp Apr 17 19:49:16 volumio volumio[10857]: info: FusionDsp - Stopping FusionDsp service Apr 17 19:49:16 volumio volumio[10857]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 19:49:16 volumio volumio[10857]: TypeError: Cannot read property 'stop' of null Apr 17 19:49:16 volumio volumio[10857]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) Apr 17 19:49:16 volumio volumio[10857]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Apr 17 19:49:16 volumio volumio[10857]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Apr 17 19:49:16 volumio volumio[10857]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1459:22) Apr 17 19:49:16 volumio volumio[10857]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1218:45) Apr 17 19:49:16 volumio volumio[10857]: at Socket.emit (events.js:315:20) Apr 17 19:49:16 volumio volumio[10857]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 17 19:49:16 volumio volumio[10857]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 17 19:49:16 volumio volumio[10857]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 17 19:49:17 volumio go-librespot[11513]: time="2024-04-17T19:49:14+02:00" level=debug msg="new websocket client" Apr 17 19:49:12 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 17 19:49:12 volumio sudo[11551]: pam_unix(sudo:session): session closed for user root Apr 17 19:49:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 17 19:49:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 17 19:49:17 volumio sudo[11565]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /etc/systemd/system/multi-user.target.wants/fusiondsp.service Apr 17 19:49:17 volumio sudo[11565]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 17 19:49:17 volumio sudo[11565]: pam_unix(sudo:session): session closed for user root Apr 17 19:49:18 volumio sudo[11543]: pam_unix(sudo:session): session closed for user root Apr 17 19:49:25 volumio sudo[11621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-17 19:48 Apr 17 19:49:25 volumio sudo[11621]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"