-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Thu 2025-03-13 17:38:19 CET. -- Mar 13 17:38:11 kiradj systemd-timedated[984]: Changed local time to Thu Mar 13 17:38:11 2025 Mar 13 17:38:11 kiradj sudo[982]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:11 kiradj volumio-time-update[565]: volumio-time-update-util: System time updated successfully. Mar 13 17:38:11 kiradj systemd[1]: Starting Daily apt download activities... Mar 13 17:38:11 kiradj systemd[1]: Started Volumio Time Update Utility. Mar 13 17:38:11 kiradj systemd[1]: Reached target Multi-User System. Mar 13 17:38:11 kiradj systemd[1]: Reached target Graphical Interface. Mar 13 17:38:11 kiradj systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 13 17:38:11 kiradj systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 13 17:38:11 kiradj systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 13 17:38:11 kiradj volumio[919]: info: MYVOLUMIO Environment detected Mar 13 17:38:11 kiradj systemd[1]: apt-daily.service: Succeeded. Mar 13 17:38:11 kiradj systemd[1]: Started Daily apt download activities. Mar 13 17:38:11 kiradj volumio[919]: info: Plugin folders cleanup Mar 13 17:38:11 kiradj volumio[919]: info: Scanning into folder /volumio/app/plugins/ Mar 13 17:38:11 kiradj volumio[919]: info: Scanning category audio_interface Mar 13 17:38:11 kiradj volumio[919]: info: Scanning category miscellanea Mar 13 17:38:11 kiradj volumio[919]: info: Scanning category music_service Mar 13 17:38:11 kiradj volumio[919]: info: Scanning category plugins.json Mar 13 17:38:11 kiradj volumio[919]: info: Scanning category system_controller Mar 13 17:38:11 kiradj volumio[919]: info: Scanning category user_interface Mar 13 17:38:11 kiradj volumio[919]: info: Scanning into folder /data/plugins/ Mar 13 17:38:11 kiradj volumio[919]: info: Scanning category audio_interface Mar 13 17:38:11 kiradj volumio[919]: info: Scanning category music_service Mar 13 17:38:11 kiradj volumio[919]: info: Plugin folders cleanup completed Mar 13 17:38:11 kiradj volumio[919]: info: ------------------------------------------- Mar 13 17:38:11 kiradj volumio[919]: info: ----- Core plugins startup ---- Mar 13 17:38:11 kiradj volumio[919]: info: ------------------------------------------- Mar 13 17:38:11 kiradj volumio[919]: info: Loading plugins from folder /volumio/app/plugins/ Mar 13 17:38:11 kiradj volumio[919]: info: Adding plugin upnp to MyMusic Plugins Mar 13 17:38:11 kiradj volumio[919]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 13 17:38:11 kiradj volumio[919]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 13 17:38:11 kiradj volumio[919]: info: Loading plugins from folder /data/plugins/ Mar 13 17:38:11 kiradj volumio[919]: info: Loading plugin "system"... Mar 13 17:38:11 kiradj systemd[1]: Starting Daily apt upgrade and clean activities... Mar 13 17:38:11 kiradj volumio[919]: info: Loading plugin "appearance"... Mar 13 17:38:11 kiradj systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 13 17:38:11 kiradj systemd[1]: Started Daily apt upgrade and clean activities. Mar 13 17:38:11 kiradj systemd[1]: Startup finished in 13.382s (kernel) + 15.785s (userspace) = 29.168s. Mar 13 17:38:12 kiradj dhcpcd[681]: wlan0: probing for an IPv4LL address Mar 13 17:38:12 kiradj volumio[919]: info: Loading plugin "network"... Mar 13 17:38:12 kiradj volumio[919]: info: Refreshing Cached IP Addresses Mar 13 17:38:12 kiradj sudo[1041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 13 17:38:12 kiradj sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:12 kiradj sudo[1041]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:12 kiradj sudo[1043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 13 17:38:12 kiradj sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:12 kiradj sudo[1043]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:12 kiradj volumio[919]: info: Loading plugin "services"... Mar 13 17:38:12 kiradj volumio[919]: info: Loading plugin "alsa_controller"... Mar 13 17:38:12 kiradj sudo[1052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 13 17:38:12 kiradj sudo[1052]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:12 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 13 17:38:12 kiradj volumio[919]: info: Loading plugin "wizard"... Mar 13 17:38:12 kiradj volumio[919]: info: Loading plugin "networkfs"... Mar 13 17:38:12 kiradj volumio[919]: info: Starting Udev Watcher for removable devices Mar 13 17:38:12 kiradj sudo[1069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=media,password=media,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.221/Musica /mnt/NAS/Musica Mar 13 17:38:12 kiradj sudo[1069]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:12 kiradj volumio[919]: info: Ignoring mount for partition: boot Mar 13 17:38:12 kiradj volumio[919]: info: Ignoring mount for partition: volumio Mar 13 17:38:12 kiradj volumio[919]: info: Ignoring mount for partition: volumio_data Mar 13 17:38:12 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 13 17:38:12 kiradj volumio[919]: info: Loading plugin "volumio_command_line_client"... Mar 13 17:38:12 kiradj volumio[919]: info: Loading plugin "upnp"... Mar 13 17:38:12 kiradj volumio[919]: info: [1741883892747] Starting Upmpd Daemon Mar 13 17:38:12 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 13 17:38:12 kiradj volumio[919]: info: Loading plugin "my_music"... Mar 13 17:38:12 kiradj volumio[919]: info: Loading plugin "mpd"... Mar 13 17:38:12 kiradj kernel: Key type cifs.spnego registered Mar 13 17:38:12 kiradj kernel: Key type cifs.idmap registered Mar 13 17:38:12 kiradj kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Mar 13 17:38:12 kiradj kernel: CIFS: Attempting to mount //192.168.0.221/Musica Mar 13 17:38:12 kiradj volumio-remote-updater[586]: [2025-03-13 17:38:12] [connect] Successful connection Mar 13 17:38:12 kiradj kernel: cryptd: max_cpu_qlen set to 1000 Mar 13 17:38:13 kiradj sudo[1069]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:13 kiradj volumio[919]: info: Loading plugin "upnp_browser"... Mar 13 17:38:13 kiradj volumio[919]: info: Loading plugin "alarm-clock"... Mar 13 17:38:13 kiradj volumio[919]: info: Loading plugin "airplay_emulation"... Mar 13 17:38:13 kiradj volumio[919]: info: Starting Shairport Sync Mar 13 17:38:13 kiradj volumio[919]: info: Loading plugin "last_100"... Mar 13 17:38:13 kiradj volumio[919]: info: Loading plugin "webradio"... Mar 13 17:38:13 kiradj volumio[919]: info: Loading plugin "i2s_dacs"... Mar 13 17:38:13 kiradj volumio[919]: info: Loading plugin "volumiodiscovery"... Mar 13 17:38:13 kiradj volumio[919]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 13 17:38:13 kiradj volumio[919]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 13 17:38:13 kiradj volumio[919]: *** WARNING *** For more information see Mar 13 17:38:13 kiradj node[919]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 13 17:38:13 kiradj volumio[919]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 13 17:38:13 kiradj volumio[919]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 13 17:38:13 kiradj volumio[919]: *** WARNING *** For more information see Mar 13 17:38:13 kiradj node[919]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 13 17:38:13 kiradj node[919]: *** WARNING *** For more information see Mar 13 17:38:13 kiradj node[919]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 13 17:38:13 kiradj node[919]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 13 17:38:13 kiradj node[919]: *** WARNING *** For more information see Mar 13 17:38:13 kiradj volumio[919]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 13 17:38:13 kiradj volumio[919]: info: Discovery: Started advertising with name: KiraDJ Mar 13 17:38:13 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 13 17:38:13 kiradj volumio[919]: info: Loading plugin "spop"... Mar 13 17:38:14 kiradj volumio[919]: info: Loading plugin "outputs"... Mar 13 17:38:14 kiradj volumio[919]: info: Loading plugin "albumart"... Mar 13 17:38:14 kiradj volumio[919]: info: Plugin example_plugin is not enabled Mar 13 17:38:14 kiradj volumio[919]: info: Loading plugin "inputs"... Mar 13 17:38:14 kiradj volumio[919]: info: Loading plugin "updater_comm"... Mar 13 17:38:15 kiradj volumio[919]: info: Plugin mpdemulation is not enabled Mar 13 17:38:15 kiradj volumio[919]: info: Loading plugin "rest_api"... Mar 13 17:38:15 kiradj volumio[919]: info: Loading plugin "websocket"... Mar 13 17:38:15 kiradj volumio[919]: info: Starting Socket.io Server version 2.3.0 Mar 13 17:38:15 kiradj volumio[919]: info: Loading plugin "fusiondsp"... Mar 13 17:38:15 kiradj volumio[919]: Forking 3 albumart workers Mar 13 17:38:15 kiradj volumio[919]: info: Applying required configuration parameters for plugin fusiondsp Mar 13 17:38:15 kiradj volumio[919]: info: Loading i18n strings for locale it Mar 13 17:38:15 kiradj volumio[919]: Updating browse sources language Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 13 17:38:15 kiradj volumio[919]: Starting albumart workers Mar 13 17:38:15 kiradj volumio[919]: Starting albumart workers Mar 13 17:38:15 kiradj volumio[919]: Starting albumart workers Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::initPlayerControls Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 17:38:15 kiradj volumio[919]: Express server listening on port 3000 Mar 13 17:38:15 kiradj volumio[919]: [Metrics] WebUI: 6s 122.60ms Mar 13 17:38:16 kiradj volumio[919]: info: CoreStateMachine::resetVolumioState Mar 13 17:38:16 kiradj volumio[919]: info: CoreStateMachine::getcurrentVolume Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioRetrievevolume Mar 13 17:38:16 kiradj volumio[919]: info: Volumio Network Manager: Network status updated: 1 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Mar 13 17:38:16 kiradj volumio-remote-updater[586]: [2025-03-13 17:38:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741883892 101 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 17:38:16 kiradj volumio[919]: info: Reloading queue from file Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Mar 13 17:38:16 kiradj volumio[919]: info: VolumeController:: Volume=30 Mute =false Mar 13 17:38:16 kiradj volumio[919]: info: CoreStateMachine::pushState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioPushState Mar 13 17:38:16 kiradj volumio[919]: info: CoreStateMachine::updateTrackBlock Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrackBlock Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioRetrievevolume Mar 13 17:38:16 kiradj volumio[919]: info: CoreStateMachine::setRepeat null single undefined Mar 13 17:38:16 kiradj volumio[919]: info: CoreStateMachine::pushState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioPushState Mar 13 17:38:16 kiradj sudo[1052]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:16 kiradj volumio[919]: info: CoreStateMachine::setRandom null Mar 13 17:38:16 kiradj volumio[919]: info: CoreStateMachine::pushState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioPushState Mar 13 17:38:16 kiradj volumio[919]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 13 17:38:16 kiradj volumio[919]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03114 Mar 13 17:38:16 kiradj volumio[919]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 13 17:38:16 kiradj volumio[919]: info: Setting Device type: Raspberry PI Mar 13 17:38:16 kiradj volumio[919]: verbose: New Socket.io Connection to 192.168.0.245 from 192.168.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 Mar 13 17:38:16 kiradj volumio[919]: info: Completed loading Core Plugins Mar 13 17:38:16 kiradj volumio[919]: info: Preparing to generate the ALSA configuration file Mar 13 17:38:16 kiradj volumio[919]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 13 17:38:16 kiradj volumio[919]: info: Reading ALSA contributions from plugins. Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: Received Get System Info Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 13 17:38:16 kiradj volumio[919]: info: Discovery: Getting this device information Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetVisibleSources Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 13 17:38:16 kiradj volumio[919]: info: Received Get System Info Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 13 17:38:16 kiradj volumio[919]: info: Discovery: Getting this device information Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: Listing playlists Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 13 17:38:16 kiradj volumio[919]: info: Discovery: adding 5d5766cc-eca5-46b1-a2b6-c1e0fd259782 Mar 13 17:38:16 kiradj volumio[919]: info: Discovery: Found device KiraDJ Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: VolumeController:: Volume=30 Mute =false Mar 13 17:38:16 kiradj volumio[919]: info: CoreStateMachine::pushState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioPushState Mar 13 17:38:16 kiradj volumio[919]: info: Discovery: this is already registered, 5d5766cc-eca5-46b1-a2b6-c1e0fd259782 Mar 13 17:38:16 kiradj volumio[919]: info: Discovery: Found device KiraDJ Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:16 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 13 17:38:16 kiradj volumio[919]: info: Asound.conf file unchanged, so no further update is needed Mar 13 17:38:16 kiradj volumio[919]: info: Output device has changed, restarting MPD Mar 13 17:38:16 kiradj volumio[919]: info: Output device has changed, restarting Shairport Sync Mar 13 17:38:16 kiradj sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 17:38:16 kiradj sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:16 kiradj sudo[1175]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:16 kiradj sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 13 17:38:16 kiradj sudo[1177]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:16 kiradj systemd[1]: Stopping Music Player Daemon... Mar 13 17:38:16 kiradj volumio[919]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 17:38:16 kiradj volumio[919]: info: ___________ START PLUGINS ___________ Mar 13 17:38:16 kiradj volumio[919]: info: ControllerMpd::onStart: Initializing MPD Mar 13 17:38:16 kiradj volumio[919]: info: Creating MPD Configuration file Mar 13 17:38:16 kiradj sudo[1184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 13 17:38:16 kiradj sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 13 17:38:16 kiradj volumio[919]: info: [1741883896616] CoreMusicLibrary::Adding element Server multimediali Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 13 17:38:16 kiradj sudo[1184]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:16 kiradj sudo[1186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 13 17:38:16 kiradj sudo[1186]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 17:38:16 kiradj systemd[1]: mpd.service: Succeeded. Mar 13 17:38:16 kiradj systemd[1]: Stopped Music Player Daemon. Mar 13 17:38:16 kiradj volumio[919]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 17:38:16 kiradj volumio[919]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 13 17:38:16 kiradj volumio[919]: info: [1741883896715] CoreMusicLibrary::Adding element Last_100 Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 13 17:38:16 kiradj volumio[919]: info: [1741883896718] CoreMusicLibrary::Adding element Webradio Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 13 17:38:16 kiradj volumio[919]: info: Initializing BBC Radios Mar 13 17:38:16 kiradj systemd[1]: Starting Music Player Daemon... Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 17:38:16 kiradj volumio[919]: info: Creating Spotify config file Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:16 kiradj sudo[1192]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 13 17:38:16 kiradj sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:16 kiradj sudo[1192]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:16 kiradj volumio[919]: info: Loading i18n strings for locale it Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 13 17:38:16 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:16 kiradj volumio[919]: info: FusionDsp - mixtype--------------------- Hardware Mar 13 17:38:16 kiradj volumio[919]: info: Volumio Calling Home Mar 13 17:38:16 kiradj volumio[919]: info: Preparing to generate the ALSA configuration file Mar 13 17:38:16 kiradj volumio[919]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 13 17:38:16 kiradj volumio[919]: info: Reading ALSA contributions from plugins. Mar 13 17:38:16 kiradj volumio[919]: info: MPD Permissions set Mar 13 17:38:16 kiradj volumio[919]: info: MPD Permissions set Mar 13 17:38:16 kiradj volumio[919]: info: FusionDsp - Mar 13 17:38:17 kiradj dhcpcd[681]: wlan0: using IPv4LL address 169.254.80.174 Mar 13 17:38:17 kiradj avahi-daemon[568]: Registering new address record for 169.254.80.174 on wlan0.IPv4. Mar 13 17:38:17 kiradj dhcpcd[681]: wlan0: adding route to 169.254.0.0/16 Mar 13 17:38:17 kiradj volumio[919]: info: FusionDsp - Mar 13 17:38:17 kiradj volumio[919]: info: FusionDsp - Mar 13 17:38:17 kiradj volumio[919]: info: FusionDsp - Mar 13 17:38:17 kiradj volumio[919]: info: FusionDsp - undefined Mar 13 17:38:17 kiradj volumio[919]: info: FusionDsp - undefined Mar 13 17:38:17 kiradj mpd[1207]: Mar 13 17:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 13 17:38:17 kiradj volumio[919]: info: FusionDsp - undefined Mar 13 17:38:17 kiradj volumio[919]: info: FusionDsp - undefined Mar 13 17:38:17 kiradj volumio[919]: info: Spotify config file written Mar 13 17:38:17 kiradj sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 13 17:38:17 kiradj sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:17 kiradj systemd[1]: Started go-librespot Daemon. Mar 13 17:38:17 kiradj go-librespot[1232]: go-librespot daemon starting... Mar 13 17:38:17 kiradj sudo[1230]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:17 kiradj volumio[919]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Mar 13 17:38:17 kiradj volumio[919]: info: Volumio called home Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:17 kiradj volumio[919]: info: No need to fix Spotify hosts Mar 13 17:38:17 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:17 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:17 kiradj volumio[919]: info: Listing playlists Mar 13 17:38:17 kiradj volumio[919]: info: Listing playlists Mar 13 17:38:17 kiradj volumio[919]: info: Starting Shairport Sync Mar 13 17:38:17 kiradj volumio[919]: info: Starting Shairport Sync Mar 13 17:38:17 kiradj systemd[1]: Started Music Player Daemon. Mar 13 17:38:17 kiradj sudo[1177]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:17 kiradj sudo[1186]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:17 kiradj volumio[919]: info: Starting Shairport Sync Mar 13 17:38:17 kiradj sudo[1248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 17:38:17 kiradj sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:17 kiradj sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 17:38:17 kiradj sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:17 kiradj sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 17:38:18 kiradj sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:18 kiradj systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::volumioGetState Mar 13 17:38:18 kiradj volumio[919]: info: CorePlayQueue::getTrack 0 Mar 13 17:38:18 kiradj systemd[1]: shairport-sync.service: Succeeded. Mar 13 17:38:18 kiradj systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 13 17:38:18 kiradj volumio[919]: info: Completed starting Core Plugins Mar 13 17:38:18 kiradj volumio[919]: info: ------------------------------------------- Mar 13 17:38:18 kiradj volumio[919]: info: ----- MyVolumio plugins startup ---- Mar 13 17:38:18 kiradj volumio[919]: info: ------------------------------------------- Mar 13 17:38:18 kiradj volumio[919]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 13 17:38:18 kiradj systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 13 17:38:18 kiradj sudo[1248]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:18 kiradj sudo[1252]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:18 kiradj systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 13 17:38:18 kiradj systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 13 17:38:18 kiradj systemd[1]: shairport-sync.service: Succeeded. Mar 13 17:38:18 kiradj systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 13 17:38:18 kiradj systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 13 17:38:18 kiradj sudo[1256]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:18 kiradj volumio[919]: info: Asound.conf file unchanged, so no further update is needed Mar 13 17:38:18 kiradj volumio[919]: info: Output device has changed, restarting MPD Mar 13 17:38:18 kiradj sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 13 17:38:18 kiradj volumio[919]: info: Output device has changed, restarting Shairport Sync Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 17:38:18 kiradj sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:18 kiradj sudo[1265]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:18 kiradj sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 13 17:38:18 kiradj sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:18 kiradj systemd[1]: Stopping Music Player Daemon... Mar 13 17:38:18 kiradj volumio[919]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 13 17:38:18 kiradj volumio[919]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 13 17:38:18 kiradj volumio[919]: SPOTIFY: BQAq7eHiNSIsqGdU0rz-OQeoHtseS4gXFy2ibIDGlAYGu1eFDEm7W_-9HPHKJrvOKU0g1t8g49BeT8jqvObHAAkR8bAOItmtQrjOCmlnXS0jtn1r1SVdCB2DPvkt2hNaNKQi2tlPc1WZcpWshkkr3kjBgdNubQLbjCi66O5MYBODVSuPwFkcznyNBCB_cPTmagvkILSONCA7GBfpGGchOCuwvo8-ju1dRIzVikd81VP2tRCh1YTzsdz4iQ-q5yoN0-Fa77qlPeWjR5_zj2yODA5RjL0sQebCGYU Mar 13 17:38:18 kiradj volumio[919]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 13 17:38:18 kiradj volumio[919]: info: New Spotify access token = BQAq7eHiNSIsqGdU0rz-OQeoHtseS4gXFy2ibIDGlAYGu1eFDEm7W_-9HPHKJrvOKU0g1t8g49BeT8jqvObHAAkR8bAOItmtQrjOCmlnXS0jtn1r1SVdCB2DPvkt2hNaNKQi2tlPc1WZcpWshkkr3kjBgdNubQLbjCi66O5MYBODVSuPwFkcznyNBCB_cPTmagvkILSONCA7GBfpGGchOCuwvo8-ju1dRIzVikd81VP2tRCh1YTzsdz4iQ-q5yoN0-Fa77qlPeWjR5_zj2yODA5RjL0sQebCGYU Mar 13 17:38:18 kiradj volumio[919]: info: Spotify credentials grant success - running version from March 24, 2019 Mar 13 17:38:18 kiradj systemd[1]: mpd.service: Succeeded. Mar 13 17:38:18 kiradj systemd[1]: Stopped Music Player Daemon. Mar 13 17:38:18 kiradj volumio[919]: info: MPD running with PID1207 Mar 13 17:38:18 kiradj volumio[919]: ,establishing connection Mar 13 17:38:18 kiradj volumio[919]: info: Shairport-Sync Started Mar 13 17:38:18 kiradj volumio[919]: Error adding Membership: Error: addMembership EINVAL Mar 13 17:38:18 kiradj volumio[919]: info: Shairport-Sync Started Mar 13 17:38:18 kiradj volumio[919]: info: Shairport-Sync Started Mar 13 17:38:18 kiradj volumio[919]: error: MPD error: Error: write EPIPE Mar 13 17:38:18 kiradj volumio[919]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Mar 13 17:38:18 kiradj systemd[1]: Starting Music Player Daemon... Mar 13 17:38:18 kiradj volumio[919]: error: MPD error: The expression evaluated to a falsy value: Mar 13 17:38:18 kiradj volumio[919]: assert.ok(self.idling) Mar 13 17:38:18 kiradj volumio[919]: error: The expression evaluated to a falsy value: Mar 13 17:38:18 kiradj volumio[919]: assert.ok(self.idling) Mar 13 17:38:18 kiradj volumio[919]: error: MPD error: Error: write EPIPE Mar 13 17:38:18 kiradj volumio[919]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Mar 13 17:38:18 kiradj volumio[919]: error: MPD error: The expression evaluated to a falsy value: Mar 13 17:38:18 kiradj volumio[919]: assert.ok(self.idling) Mar 13 17:38:18 kiradj volumio[919]: error: The expression evaluated to a falsy value: Mar 13 17:38:18 kiradj volumio[919]: assert.ok(self.idling) Mar 13 17:38:18 kiradj volumio[919]: info: MPD Permissions set Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj sudo[1273]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 13 17:38:18 kiradj sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=info msg="running go-librespot 0.2.0" Mar 13 17:38:18 kiradj sudo[1273]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=debug msg="app state loaded" Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj volumio[919]: info: Starting Shairport Sync Mar 13 17:38:18 kiradj sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 13 17:38:18 kiradj sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:18 kiradj systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 13 17:38:18 kiradj systemd[1]: shairport-sync.service: Succeeded. Mar 13 17:38:18 kiradj systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 13 17:38:18 kiradj volumio[919]: SPOTIFY: User informations: {"country":"IT","display_name":"ducaakira","email":"ducaakira79@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/niuolg1j829z47fou7pyxg8u9"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/niuolg1j829z47fou7pyxg8u9","id":"niuolg1j829z47fou7pyxg8u9","images":[],"product":"free","type":"user","uri":"spotify:user:niuolg1j829z47fou7pyxg8u9"} Mar 13 17:38:18 kiradj volumio[919]: info: Spotify Successfully logged in Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 13 17:38:18 kiradj volumio[919]: info: [1741883898518] CoreMusicLibrary::Adding element Spotify Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 13 17:38:18 kiradj volumio[919]: Cannot find translation for source Spotify Mar 13 17:38:18 kiradj systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 13 17:38:18 kiradj sudo[1282]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:18 kiradj volumio[919]: info: Shairport-Sync Started Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=info msg="zeroconf server listening on port 45045" Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=debug msg="obtained new client token: AACA1mdm/8JL7JgzVz1xZjOgqlSXFWiO9Vb6TYHVWbJjecxvHIHf//ghcdnjAD+1gBNLDLVp1+yuh89sqSkLLSZbyGR4sF2465M0jCjDqStqifRqnVsS+X5t/wbyVTRi9YJ7N1vFJaHTDjVd2UFiVz89piGbxefVsqJZfmqjzI5AhzEIbvxGhl0Oqy754u4JUF8znUT77nfeXkQbZdyGIn30pc8oen5lMQaQcardsX/3jpYWb31AeFCouA==" Mar 13 17:38:18 kiradj ntpd[805]: Listen normally on 5 wlan0 169.254.80.174:123 Mar 13 17:38:18 kiradj ntpd[805]: new interface(s) found: waking up resolver Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Mar 13 17:38:18 kiradj volumio[919]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Mar 13 17:38:18 kiradj volumio[919]: info: camilladsp service started and running in background, instance 1 Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=debug msg="completed keyexchange" Mar 13 17:38:18 kiradj go-librespot[1232]: time="2025-03-13T17:38:18+01:00" level=debug msg="completed challenge" Mar 13 17:38:18 kiradj volumio[919]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 13 17:38:18 kiradj volumio[919]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 13 17:38:18 kiradj volumio[919]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 13 17:38:18 kiradj volumio[919]: info: FusionDsp loaded Mar 13 17:38:18 kiradj volumio[919]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 13 17:38:18 kiradj sudo[1299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 13 17:38:18 kiradj sudo[1299]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:18 kiradj volumio[919]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 13 17:38:18 kiradj volumio[919]: info: Adding Signal Path Element [object Object] Mar 13 17:38:18 kiradj volumio[919]: info: Adding fusiondspeq DSP Signal Path Element Mar 13 17:38:18 kiradj volumio[919]: info: FusionDsp - ---- installed callbackRead Mar 13 17:38:18 kiradj volumio[919]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 17:38:19 kiradj sudo[1299]: pam_unix(sudo:session): session closed for user root Mar 13 17:38:19 kiradj volumio[919]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 13 17:38:19 kiradj volumio[919]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Mar 13 17:38:19 kiradj volumio[919]: at onErrorNT (internal/child_process.js:465:16) Mar 13 17:38:19 kiradj volumio[919]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 13 17:38:19 kiradj volumio[919]: at runNextTicks (internal/process/task_queues.js:62:3) Mar 13 17:38:19 kiradj volumio[919]: at listOnTimeout (internal/timers.js:523:9) Mar 13 17:38:19 kiradj volumio[919]: at processTimers (internal/timers.js:497:7) { Mar 13 17:38:19 kiradj volumio[919]: errno: -2, Mar 13 17:38:19 kiradj volumio[919]: code: 'ENOENT', Mar 13 17:38:19 kiradj volumio[919]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 13 17:38:19 kiradj volumio[919]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 13 17:38:19 kiradj volumio[919]: spawnargs: [ Mar 13 17:38:19 kiradj volumio[919]: '-p', Mar 13 17:38:19 kiradj volumio[919]: 9876, Mar 13 17:38:19 kiradj volumio[919]: '-o', Mar 13 17:38:19 kiradj volumio[919]: '/tmp/camilladsp.log', Mar 13 17:38:19 kiradj volumio[919]: '-l', Mar 13 17:38:19 kiradj volumio[919]: 'warn', Mar 13 17:38:19 kiradj volumio[919]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 13 17:38:19 kiradj volumio[919]: ] Mar 13 17:38:19 kiradj volumio[919]: } Mar 13 17:38:19 kiradj volumio[919]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=info msg="authenticated AP as niuolg1j829z47fou7pyxg8u9" Mar 13 17:38:19 kiradj mpd[1277]: Mar 13 17:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=info msg="authenticated Login5 as niuolg1j829z47fou7pyxg8u9" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=debug msg="initializing zeroconf session, username: niuolg1j829z47fou7pyxg8u9" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=debug msg="dealer connection opened" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=trace msg="starting accesspoint recv loop" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=trace msg="starting dealer recv loop" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=trace msg="received accesspoint ping" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=debug msg="received connection id: NGRiYTVlMDMtMzcyYS00MWFhLWE1NjEtMzBlYTA4MzViYjEwK2RlYWxlcit0Y3A6Ly8wYWNhNTg5OC5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArRUE2MzFGNjJFMzI0RDFBRDk0MTYwRENEMzM3MjZFRjkxNzZEOTNCQ0UwMUZGODI0NDZCRjUyMjgyRUYxM0MyNw==" Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=trace msg="received accesspoint pong ack" Mar 13 17:38:19 kiradj sudo[1310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-13 17:37 Mar 13 17:38:19 kiradj sudo[1310]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 13 17:38:19 kiradj go-librespot[1232]: time="2025-03-13T17:38:19+01:00" level=debug msg="put connect state because NEW_DEVICE" 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"