-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2025-06-05 18:16:01 CST. -- Jun 05 18:15:48 volumio systemd-timedated[1048]: Changed local time to Thu Jun 5 18:15:48 2025 Jun 05 18:15:48 volumio sudo[1046]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:48 volumio volumio-time-update[635]: volumio-time-update-util: System time updated successfully. Jun 05 18:15:48 volumio systemd[1]: Started Volumio Time Update Utility. Jun 05 18:15:48 volumio systemd[1]: Starting Daily apt download activities... Jun 05 18:15:48 volumio systemd[1]: Reached target Multi-User System. Jun 05 18:15:48 volumio systemd[1]: Reached target Graphical Interface. Jun 05 18:15:48 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 05 18:15:48 volumio systemd[1]: Starting Daily man-db regeneration... Jun 05 18:15:48 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 05 18:15:48 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 05 18:15:48 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jun 05 18:15:48 volumio nmbd[766]: [2025/06/05 18:15:48.645652, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jun 05 18:15:48 volumio nmbd[766]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.111 for name WORKGROUP<1d>. Jun 05 18:15:48 volumio nmbd[766]: This response was from IP 192.168.1.122, reporting an IP address of 192.168.1.122. Jun 05 18:15:48 volumio systemd[1]: man-db.service: Succeeded. Jun 05 18:15:48 volumio systemd[1]: Started Daily man-db regeneration. Jun 05 18:15:49 volumio volumio[998]: info: Loading plugin "network"... Jun 05 18:15:49 volumio volumio[998]: info: Refreshing Cached IP Addresses Jun 05 18:15:49 volumio sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 05 18:15:49 volumio sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:49 volumio sudo[1078]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:49 volumio sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 05 18:15:49 volumio sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:49 volumio sudo[1080]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:49 volumio volumio[998]: info: Loading plugin "services"... Jun 05 18:15:49 volumio volumio[998]: info: Loading plugin "alsa_controller"... Jun 05 18:15:49 volumio sudo[1090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 05 18:15:49 volumio sudo[1090]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:49 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 05 18:15:49 volumio volumio[998]: info: Loading plugin "wizard"... Jun 05 18:15:49 volumio volumio[998]: info: Loading plugin "networkfs"... Jun 05 18:15:49 volumio volumio[998]: info: Starting Udev Watcher for removable devices Jun 05 18:15:49 volumio sudo[1106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=scott,password=00000000,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.122/app-data/BACKUP/new/media/music/itune /mnt/NAS/music-m4a Jun 05 18:15:49 volumio sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:49 volumio volumio[998]: info: Ignoring mount for partition: boot Jun 05 18:15:49 volumio volumio[998]: info: Ignoring mount for partition: volumio Jun 05 18:15:49 volumio volumio[998]: info: Ignoring mount for partition: volumio_data Jun 05 18:15:49 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 05 18:15:49 volumio volumio[998]: info: Loading plugin "volumio_command_line_client"... Jun 05 18:15:50 volumio volumio[998]: info: Loading plugin "upnp"... Jun 05 18:15:50 volumio volumio[998]: info: [1749118550151] Starting Upmpd Daemon Jun 05 18:15:50 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 05 18:15:50 volumio volumio[998]: info: Loading plugin "my_music"... Jun 05 18:15:50 volumio volumio[998]: info: Loading plugin "mpd"... Jun 05 18:15:50 volumio kernel: Key type cifs.spnego registered Jun 05 18:15:50 volumio kernel: Key type cifs.idmap registered Jun 05 18:15:50 volumio 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. Jun 05 18:15:50 volumio kernel: CIFS: Attempting to mount //192.168.1.122/app-data/BACKUP/new/media/music/itune Jun 05 18:15:50 volumio sh[505]: timed out Jun 05 18:15:50 volumio dhcpcd[559]: timed out Jun 05 18:15:50 volumio sh[505]: dhcpcd exited Jun 05 18:15:50 volumio dhcpcd[559]: dhcpcd exited Jun 05 18:15:50 volumio sh[505]: ifup: failed to bring up eth0 Jun 05 18:15:50 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jun 05 18:15:50 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jun 05 18:15:50 volumio kernel: cryptd: max_cpu_qlen set to 1000 Jun 05 18:15:51 volumio volumio[998]: info: Loading plugin "upnp_browser"... Jun 05 18:15:51 volumio sudo[1106]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:52 volumio volumio[998]: info: Loading plugin "alarm-clock"... Jun 05 18:15:52 volumio volumio[998]: info: Loading plugin "airplay_emulation"... Jun 05 18:15:52 volumio volumio[998]: info: Starting Shairport Sync Jun 05 18:15:52 volumio volumio[998]: info: Loading plugin "last_100"... Jun 05 18:15:52 volumio volumio[998]: info: Loading plugin "webradio"... Jun 05 18:15:52 volumio volumio[998]: info: Loading plugin "i2s_dacs"... Jun 05 18:15:52 volumio volumio[998]: info: Loading plugin "volumiodiscovery"... Jun 05 18:15:52 volumio volumio[998]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 05 18:15:52 volumio volumio[998]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 05 18:15:52 volumio volumio[998]: *** WARNING *** For more information see Jun 05 18:15:52 volumio node[998]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 05 18:15:52 volumio volumio[998]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 05 18:15:52 volumio volumio[998]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 05 18:15:52 volumio volumio[998]: *** WARNING *** For more information see Jun 05 18:15:52 volumio node[998]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 05 18:15:52 volumio node[998]: *** WARNING *** For more information see Jun 05 18:15:52 volumio node[998]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 05 18:15:52 volumio node[998]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 05 18:15:52 volumio node[998]: *** WARNING *** For more information see Jun 05 18:15:52 volumio volumio[998]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 05 18:15:52 volumio volumio[998]: info: Discovery: Started advertising with name: Volumio Jun 05 18:15:52 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 05 18:15:52 volumio volumio[998]: info: Loading plugin "spop"... Jun 05 18:15:53 volumio sudo[1090]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:53 volumio systemd[1]: apt-daily.service: Succeeded. Jun 05 18:15:53 volumio systemd[1]: Started Daily apt download activities. Jun 05 18:15:53 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jun 05 18:15:53 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jun 05 18:15:54 volumio volumio-remote-updater[627]: [2025-06-05 18:15:54] [connect] Successful connection Jun 05 18:15:54 volumio volumio[998]: info: Loading plugin "outputs"... Jun 05 18:15:55 volumio volumio[998]: info: Loading plugin "albumart"... Jun 05 18:15:55 volumio volumio[998]: info: Plugin example_plugin is not enabled Jun 05 18:15:55 volumio volumio[998]: info: Loading plugin "inputs"... Jun 05 18:15:55 volumio volumio[998]: info: Loading plugin "updater_comm"... Jun 05 18:15:55 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jun 05 18:15:55 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jun 05 18:15:55 volumio systemd[1]: Startup finished in 14.421s (kernel) + 41.148s (userspace) = 55.570s. Jun 05 18:15:55 volumio volumio[998]: info: Plugin mpdemulation is not enabled Jun 05 18:15:55 volumio volumio[998]: info: Loading plugin "rest_api"... Jun 05 18:15:55 volumio volumio[998]: info: Loading plugin "websocket"... Jun 05 18:15:55 volumio volumio[998]: info: Starting Socket.io Server version 2.3.0 Jun 05 18:15:55 volumio volumio[998]: info: Loading plugin "fusiondsp"... Jun 05 18:15:55 volumio volumio[998]: Forking 3 albumart workers Jun 05 18:15:55 volumio volumio[998]: info: Applying required configuration parameters for plugin fusiondsp Jun 05 18:15:56 volumio volumio[998]: info: Loading plugin "touch_display"... Jun 05 18:15:56 volumio volumio[998]: Starting albumart workers Jun 05 18:15:56 volumio volumio[998]: Starting albumart workers Jun 05 18:15:56 volumio volumio[998]: Starting albumart workers Jun 05 18:15:56 volumio volumio[998]: info: Applying required configuration parameters for plugin touch_display Jun 05 18:15:57 volumio volumio[998]: info: Loading i18n strings for locale zh_TW Jun 05 18:15:57 volumio volumio[998]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 05 18:15:57 volumio volumio[998]: Updating browse sources language Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::initPlayerControls Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 05 18:15:57 volumio volumio[998]: Express server listening on port 3000 Jun 05 18:15:57 volumio volumio[998]: [Metrics] WebUI: 13s 115.41ms Jun 05 18:15:57 volumio volumio[998]: info: CoreStateMachine::resetVolumioState Jun 05 18:15:57 volumio volumio[998]: info: CoreStateMachine::getcurrentVolume Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::volumioRetrievevolume Jun 05 18:15:57 volumio volumio[998]: info: Volumio Network Manager: Network status updated: 2 Jun 05 18:15:57 volumio volumio-remote-updater[627]: [2025-06-05 18:15:57] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749118554 101 Jun 05 18:15:57 volumio volumio[998]: 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: 1 Jun 05 18:15:57 volumio volumio[998]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 05 18:15:57 volumio volumio[998]: info: Reloading queue from file Jun 05 18:15:57 volumio volumio[998]: info: VolumeController:: Volume=93 Mute =false Jun 05 18:15:57 volumio volumio[998]: info: CoreStateMachine::pushState Jun 05 18:15:57 volumio volumio[998]: info: CorePlayQueue::getTrack 0 Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jun 05 18:15:57 volumio volumio[998]: info: CoreStateMachine::updateTrackBlock Jun 05 18:15:57 volumio volumio[998]: info: CorePlayQueue::getTrackBlock Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::volumioRetrievevolume Jun 05 18:15:57 volumio volumio[998]: info: CoreStateMachine::setRepeat true single undefined Jun 05 18:15:57 volumio volumio[998]: info: CoreStateMachine::pushState Jun 05 18:15:57 volumio volumio[998]: info: CorePlayQueue::getTrack 0 Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jun 05 18:15:57 volumio volumio[998]: info: CoreStateMachine::setRandom false Jun 05 18:15:57 volumio volumio[998]: info: CoreStateMachine::pushState Jun 05 18:15:57 volumio volumio[998]: info: CorePlayQueue::getTrack 0 Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jun 05 18:15:57 volumio volumio[998]: info: Setting Device type: Raspberry PI Jun 05 18:15:57 volumio volumio[998]: info: Completed loading Core Plugins Jun 05 18:15:57 volumio volumio[998]: info: Preparing to generate the ALSA configuration file Jun 05 18:15:57 volumio volumio[998]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 05 18:15:57 volumio volumio[998]: info: Reading ALSA contributions from plugins. Jun 05 18:15:57 volumio volumio[998]: info: Discovery: adding 6da0e6be-bd16-4e87-b26b-78918a809ec8 Jun 05 18:15:57 volumio volumio[998]: info: Discovery: Found device Volumio Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::volumioGetState Jun 05 18:15:57 volumio volumio[998]: info: CorePlayQueue::getTrack 0 Jun 05 18:15:57 volumio volumio[998]: info: VolumeController:: Volume=93 Mute =false Jun 05 18:15:57 volumio volumio[998]: info: CoreStateMachine::pushState Jun 05 18:15:57 volumio volumio[998]: info: CorePlayQueue::getTrack 0 Jun 05 18:15:57 volumio volumio[998]: info: CoreCommandRouter::volumioPushState Jun 05 18:15:57 volumio volumio[998]: info: Asound.conf file unchanged, so no further update is needed Jun 05 18:15:57 volumio volumio[998]: info: Output device has changed, restarting MPD Jun 05 18:15:58 volumio volumio[998]: info: Output device has changed, restarting Shairport Sync Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 05 18:15:58 volumio sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:58 volumio sudo[1291]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:58 volumio sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 05 18:15:58 volumio sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:58 volumio systemd[1]: Stopping Music Player Daemon... Jun 05 18:15:58 volumio volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 05 18:15:58 volumio volumio[998]: info: ___________ START PLUGINS ___________ Jun 05 18:15:58 volumio volumio[998]: info: ControllerMpd::onStart: Initializing MPD Jun 05 18:15:58 volumio volumio[998]: info: Creating MPD Configuration file Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 05 18:15:58 volumio sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 05 18:15:58 volumio sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:58 volumio volumio[998]: info: [1749118558109] CoreMusicLibrary::Adding element Media Servers Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 05 18:15:58 volumio sudo[1300]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:58 volumio sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 05 18:15:58 volumio sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 05 18:15:58 volumio volumio[998]: info: [1749118558242] CoreMusicLibrary::Adding element Last_100 Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 05 18:15:58 volumio volumio[998]: info: [1749118558246] CoreMusicLibrary::Adding element Webradio Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 05 18:15:58 volumio volumio[998]: info: Initializing BBC Radios Jun 05 18:15:58 volumio systemd[1]: mpd.service: Succeeded. Jun 05 18:15:58 volumio systemd[1]: Stopped Music Player Daemon. Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: Creating Spotify config file Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio systemd[1]: Starting Music Player Daemon... Jun 05 18:15:58 volumio volumio[998]: info: Loading i18n strings for locale zh_TW Jun 05 18:15:58 volumio volumio[998]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: FusionDsp - mixtype--------------------- Hardware Jun 05 18:15:58 volumio volumio[998]: info: Loading i18n strings for locale zh_TW Jun 05 18:15:58 volumio volumio[998]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 05 18:15:58 volumio volumio[998]: info: Volumio Calling Home Jun 05 18:15:58 volumio sudo[1317]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 05 18:15:58 volumio sudo[1317]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:58 volumio sudo[1317]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:58 volumio volumio[998]: info: Preparing to generate the ALSA configuration file Jun 05 18:15:58 volumio sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Jun 05 18:15:58 volumio sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:58 volumio sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Jun 05 18:15:58 volumio sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:58 volumio sudo[1333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jun 05 18:15:58 volumio sudo[1333]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:58 volumio volumio[998]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 05 18:15:58 volumio volumio[998]: info: Reading ALSA contributions from plugins. Jun 05 18:15:58 volumio volumio[998]: info: touch_display: No backlight interface detected. Jun 05 18:15:58 volumio volumio[998]: info: MPD Permissions set Jun 05 18:15:58 volumio volumio[998]: info: MPD Permissions set Jun 05 18:15:58 volumio volumio[998]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 05 18:15:58 volumio volumio[998]: info: Spotify config file written Jun 05 18:15:58 volumio systemd[1]: Reloading. Jun 05 18:15:58 volumio sudo[1328]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio sudo[1337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 05 18:15:58 volumio sudo[1337]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: No need to fix Spotify hosts Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 05 18:15:58 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: touch_display: systemctl stop getty@tty1.service succeeded. Jun 05 18:15:59 volumio volumio[998]: info: Volumio called home Jun 05 18:15:59 volumio volumio[998]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Jun 05 18:15:59 volumio sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::volumioGetState Jun 05 18:15:59 volumio volumio[998]: info: CorePlayQueue::getTrack 0 Jun 05 18:15:59 volumio sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:59 volumio volumio[998]: info: Starting Shairport Sync Jun 05 18:15:59 volumio volumio[998]: info: Starting Shairport Sync Jun 05 18:15:59 volumio sudo[1361]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:59 volumio volumio[998]: info: Starting Shairport Sync Jun 05 18:15:59 volumio sudo[1364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 05 18:15:59 volumio sudo[1364]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:59 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. Jun 05 18:15:59 volumio sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 05 18:15:59 volumio sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:59 volumio sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 05 18:15:59 volumio sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:59 volumio volumio[998]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Jun 05 18:15:59 volumio volumio[998]: info: Asound.conf file unchanged, so no further update is needed Jun 05 18:15:59 volumio volumio[998]: info: Output device has changed, restarting MPD Jun 05 18:15:59 volumio volumio[998]: info: Output device has changed, restarting Shairport Sync Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 05 18:15:59 volumio sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 05 18:15:59 volumio sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:59 volumio sudo[1387]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:59 volumio sudo[1389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 05 18:15:59 volumio sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:59 volumio volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 05 18:15:59 volumio volumio[998]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 05 18:15:59 volumio volumio[998]: SPOTIFY: BQAUWs_rrYrEqJ3HhPAoTMyh7aeX5MWEpXhE7qNreQqQl7PwWRImUV1djEcAZZTO9vnIeAoN3i0GdsCLkmam5FSxIJ165WChU6QDmccasPQNtvpScCAmvaG11ZfabRlebBsxBeYjcuKezyh1UEeVZPk6tKocaMW-MHXiq3xH_vyvdHKB5_eYTH94xjTsn3uskOqjBsBDfmOkvE2z7F05tSlSlodPvRz19FcaxRJ30nUoeigmazgaJ7wlk8Cjs5HlOrLZl3_tUccns-dSme37fuW3A9iZ Jun 05 18:15:59 volumio volumio[998]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jun 05 18:15:59 volumio volumio[998]: info: New Spotify access token = BQAUWs_rrYrEqJ3HhPAoTMyh7aeX5MWEpXhE7qNreQqQl7PwWRImUV1djEcAZZTO9vnIeAoN3i0GdsCLkmam5FSxIJ165WChU6QDmccasPQNtvpScCAmvaG11ZfabRlebBsxBeYjcuKezyh1UEeVZPk6tKocaMW-MHXiq3xH_vyvdHKB5_eYTH94xjTsn3uskOqjBsBDfmOkvE2z7F05tSlSlodPvRz19FcaxRJ30nUoeigmazgaJ7wlk8Cjs5HlOrLZl3_tUccns-dSme37fuW3A9iZ Jun 05 18:15:59 volumio volumio[998]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 05 18:15:59 volumio volumio[998]: info: MPD Permissions set Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:15:59 volumio volumio[998]: info: Starting Shairport Sync Jun 05 18:15:59 volumio sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 05 18:15:59 volumio sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:15:59 volumio volumio[998]: SPOTIFY: User informations: {"country":"TW","display_name":"Scott Fang","email":"fanscott328@me.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/fanscott328"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/fanscott328","id":"fanscott328","images":[{"height":300,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=1341493649199225&height=300&width=300&ext=1751691108&hash=AT-FFCx0001MEnzSi5cJNfm_","width":300},{"height":64,"url":"https://platform-lookaside.fbsbx.com/platform/profilepic/?asid=1341493649199225&height=50&width=50&ext=1751691108&hash=AT_7g7kyOp7Swp5MSy_PMV5t","width":64}],"product":"premium","type":"user","uri":"spotify:user:fanscott328"} Jun 05 18:15:59 volumio volumio[998]: info: Spotify Successfully logged in Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 05 18:15:59 volumio volumio[998]: info: [1749118559596] CoreMusicLibrary::Adding element Spotify Jun 05 18:15:59 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 05 18:15:59 volumio volumio[998]: Cannot find translation for source Spotify Jun 05 18:15:59 volumio sudo[1333]: pam_unix(sudo:session): session closed for user root Jun 05 18:15:59 volumio volumio[998]: info: touch_display: systemctl daemon-reload succeeded. Jun 05 18:15:59 volumio systemd[1]: Reloading. Jun 05 18:15:59 volumio sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Jun 05 18:15:59 volumio sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:16:00 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. Jun 05 18:16:00 volumio sudo[1419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 05 18:16:00 volumio sudo[1419]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:16:00 volumio sudo[1419]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:00 volumio sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 05 18:16:00 volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:16:00 volumio sudo[1421]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:00 volumio sudo[1425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 05 18:16:00 volumio sudo[1425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:16:00 volumio mpd[1325]: Jun 05 18:16 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 05 18:16:00 volumio volumio[998]: info: camilladsp service started and running in background, instance 1 Jun 05 18:16:00 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 05 18:16:00 volumio volumio[998]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 05 18:16:00 volumio volumio[998]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 05 18:16:00 volumio volumio[998]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 05 18:16:00 volumio volumio[998]: info: FusionDsp loaded Jun 05 18:16:00 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 05 18:16:00 volumio sudo[1437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 05 18:16:00 volumio sudo[1437]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:16:00 volumio volumio[998]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 05 18:16:00 volumio volumio[998]: info: Adding Signal Path Element [object Object] Jun 05 18:16:00 volumio volumio[998]: info: Adding fusiondspeq DSP Signal Path Element Jun 05 18:16:00 volumio volumio[998]: info: FusionDsp - ---- installed callbackRead Jun 05 18:16:00 volumio volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 05 18:16:00 volumio sudo[1330]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:00 volumio volumio[998]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 05 18:16:00 volumio volumio[998]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 05 18:16:00 volumio volumio[998]: at onErrorNT (internal/child_process.js:465:16) Jun 05 18:16:00 volumio volumio[998]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jun 05 18:16:00 volumio volumio[998]: errno: -2, Jun 05 18:16:00 volumio volumio[998]: code: 'ENOENT', Jun 05 18:16:00 volumio volumio[998]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 05 18:16:00 volumio volumio[998]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 05 18:16:00 volumio volumio[998]: spawnargs: [ Jun 05 18:16:00 volumio volumio[998]: '-p', Jun 05 18:16:00 volumio volumio[998]: 9876, Jun 05 18:16:00 volumio volumio[998]: '-o', Jun 05 18:16:00 volumio volumio[998]: '/tmp/camilladsp.log', Jun 05 18:16:00 volumio volumio[998]: '-l', Jun 05 18:16:00 volumio volumio[998]: 'warn', Jun 05 18:16:00 volumio volumio[998]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 05 18:16:00 volumio volumio[998]: ] Jun 05 18:16:00 volumio volumio[998]: } Jun 05 18:16:00 volumio volumio[998]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 05 18:16:00 volumio sudo[1437]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:00 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 05 18:16:00 volumio sudo[1425]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:00 volumio systemd[1]: Started Volumio Kiosk. Jun 05 18:16:00 volumio systemd[1]: Stopping Music Player Daemon... Jun 05 18:16:00 volumio sudo[1403]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 05 18:16:00 volumio systemd[1]: Started go-librespot Daemon. Jun 05 18:16:00 volumio sudo[1337]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:00 volumio go-librespot[1451]: go-librespot daemon starting... Jun 05 18:16:00 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 05 18:16:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 05 18:16:00 volumio systemd[1]: mpd.service: Succeeded. Jun 05 18:16:00 volumio systemd[1]: Stopped Music Player Daemon. Jun 05 18:16:01 volumio systemd[1]: Starting Music Player Daemon... Jun 05 18:16:01 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 05 18:16:01 volumio sudo[1369]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:01 volumio sudo[1400]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:01 volumio sudo[1366]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:01 volumio sudo[1364]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:01 volumio sudo[1465]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 05 18:16:01 volumio sudo[1465]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:16:01 volumio sudo[1465]: pam_unix(sudo:session): session closed for user root Jun 05 18:16:01 volumio sudo[1487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-05 18:15 Jun 05 18:16:01 volumio sudo[1487]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"