-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Mon 2025-05-05 20:29:58 +07. -- May 05 20:29:48 volumio systemd-timedated[1000]: Changed local time to Mon May 5 20:29:48 2025 May 05 20:29:48 volumio sudo[998]: pam_unix(sudo:session): session closed for user root May 05 20:29:48 volumio volumio-time-update[594]: volumio-time-update-util: System time updated successfully. May 05 20:29:48 volumio systemd[1]: Starting Daily apt download activities... May 05 20:29:48 volumio systemd[1]: Started Volumio Time Update Utility. May 05 20:29:48 volumio nmbd[825]: [2025/05/05 20:29:48.140735, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 20:29:48 volumio nmbd[825]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 05 20:29:48 volumio systemd[1]: Started Samba NMB Daemon. May 05 20:29:48 volumio systemd[1]: Starting Samba Winbind Daemon... May 05 20:29:48 volumio winbindd[1006]: [2025/05/05 20:29:48.401372, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 05 20:29:48 volumio winbindd[1006]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 05 20:29:48 volumio winbindd[1006]: [2025/05/05 20:29:48.469611, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 20:29:48 volumio systemd[1]: Started Samba Winbind Daemon. May 05 20:29:48 volumio winbindd[1006]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 05 20:29:48 volumio systemd[1]: Starting Samba SMB Daemon... May 05 20:29:49 volumio smbd[1026]: [2025/05/05 20:29:49.174839, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 05 20:29:49 volumio smbd[1026]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 05 20:29:49 volumio systemd[1]: Started Samba SMB Daemon. May 05 20:29:49 volumio systemd[1]: Reached target Multi-User System. May 05 20:29:49 volumio systemd[1]: Reached target Graphical Interface. May 05 20:29:49 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 05 20:29:49 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 05 20:29:49 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 05 20:29:50 volumio systemd[1]: apt-daily.service: Succeeded. May 05 20:29:50 volumio systemd[1]: Started Daily apt download activities. May 05 20:29:50 volumio systemd[1]: Starting Daily apt upgrade and clean activities... May 05 20:29:51 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. May 05 20:29:51 volumio systemd[1]: Started Daily apt upgrade and clean activities. May 05 20:29:51 volumio systemd[1]: Startup finished in 12.342s (kernel) + 19.042s (userspace) = 31.384s. May 05 20:29:51 volumio volumio[893]: info: Loading plugin "ytmusic"... May 05 20:29:53 volumio volumio[893]: info: Loading plugin "outputs"... May 05 20:29:53 volumio volumio[893]: info: Loading plugin "albumart"... May 05 20:29:53 volumio volumio[893]: info: Plugin example_plugin is not enabled May 05 20:29:53 volumio volumio[893]: info: Loading plugin "inputs"... May 05 20:29:53 volumio volumio[893]: info: Loading plugin "updater_comm"... May 05 20:29:53 volumio volumio-remote-updater[601]: [2025-05-05 20:29:53] [connect] Successful connection May 05 20:29:53 volumio volumio[893]: info: Plugin mpdemulation is not enabled May 05 20:29:53 volumio volumio[893]: info: Loading plugin "rest_api"... May 05 20:29:54 volumio volumio[893]: info: Loading plugin "websocket"... May 05 20:29:54 volumio volumio[893]: info: Starting Socket.io Server version 2.3.0 May 05 20:29:54 volumio volumio[893]: info: Loading plugin "fusiondsp"... May 05 20:29:54 volumio volumio[893]: Forking 3 albumart workers May 05 20:29:54 volumio volumio[893]: info: Applying required configuration parameters for plugin fusiondsp May 05 20:29:54 volumio volumio[893]: info: Loading plugin "mpd_oled"... May 05 20:29:54 volumio volumio[893]: Starting albumart workers May 05 20:29:54 volumio volumio[893]: Starting albumart workers May 05 20:29:54 volumio volumio[893]: Starting albumart workers May 05 20:29:54 volumio volumio[893]: info: Applying required configuration parameters for plugin mpd_oled May 05 20:29:54 volumio volumio[893]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json May 05 20:29:54 volumio volumio[893]: info: Loading plugin "pirateaudio"... May 05 20:29:54 volumio volumio[893]: info: Applying required configuration parameters for plugin pirateaudio May 05 20:29:54 volumio volumio[893]: info: Loading i18n strings for locale vi May 05 20:29:54 volumio volumio[893]: Updating browse sources language May 05 20:29:54 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::initPlayerControls May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 05 20:29:55 volumio volumio[893]: Express server listening on port 3000 May 05 20:29:55 volumio volumio[893]: [Metrics] WebUI: 14s 743.95ms May 05 20:29:55 volumio volumio[893]: info: CoreStateMachine::resetVolumioState May 05 20:29:55 volumio volumio[893]: info: CoreStateMachine::getcurrentVolume May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioRetrievevolume May 05 20:29:55 volumio sudo[1188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 05 20:29:55 volumio sudo[1188]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:55 volumio sudo[1188]: pam_unix(sudo:session): session closed for user root May 05 20:29:55 volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 05 20:29:55 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:55 volumio sudo[1191]: pam_unix(sudo:session): session closed for user root May 05 20:29:55 volumio volumio[893]: info: Volumio Network Manager: Network status updated: 0 May 05 20:29:55 volumio volumio[893]: info: CoreStateMachine::pushState May 05 20:29:55 volumio volumio[893]: info: CorePlayQueue::getTrack 0 May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioPushState May 05 20:29:55 volumio volumio[893]: info: CoreStateMachine::updateTrackBlock May 05 20:29:55 volumio volumio[893]: info: CorePlayQueue::getTrackBlock May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioRetrievevolume May 05 20:29:55 volumio volumio-remote-updater[601]: [2025-05-05 20:29:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1746451793 101 May 05 20:29:55 volumio volumio[893]: 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 May 05 20:29:55 volumio volumio[893]: info: CoreStateMachine::pushState May 05 20:29:55 volumio volumio[893]: info: CorePlayQueue::getTrack 0 May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioPushState May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:55 volumio volumio[893]: info: Reloading queue from file May 05 20:29:55 volumio volumio[893]: info: Setting Device type: Raspberry PI May 05 20:29:55 volumio volumio[893]: info: CoreStateMachine::setRepeat true single undefined May 05 20:29:55 volumio volumio[893]: info: CoreStateMachine::pushState May 05 20:29:55 volumio volumio[893]: info: CorePlayQueue::getTrack 0 May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioPushState May 05 20:29:55 volumio volumio[893]: info: CoreStateMachine::setRandom false May 05 20:29:55 volumio volumio[893]: info: CoreStateMachine::pushState May 05 20:29:55 volumio volumio[893]: info: CorePlayQueue::getTrack 0 May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioPushState May 05 20:29:55 volumio volumio[893]: info: Completed loading Core Plugins May 05 20:29:55 volumio volumio[893]: info: Preparing to generate the ALSA configuration file May 05 20:29:55 volumio volumio[893]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 05 20:29:55 volumio volumio[893]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 May 05 20:29:55 volumio volumio[893]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 05 20:29:55 volumio volumio[893]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 05 20:29:55 volumio volumio[893]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 05 20:29:55 volumio volumio[893]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf May 05 20:29:55 volumio volumio[893]: info: Reading ALSA contributions from plugins. May 05 20:29:55 volumio volumio[893]: info: Discovery: A device disappeared from network May 05 20:29:55 volumio volumio[893]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined May 05 20:29:55 volumio sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 05 20:29:55 volumio sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:55 volumio volumio[893]: info: Asound.conf file unchanged, so no further update is needed May 05 20:29:55 volumio volumio[893]: info: Output device has changed, restarting MPD May 05 20:29:55 volumio sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 05 20:29:55 volumio sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:55 volumio volumio[893]: info: Output device has changed, restarting Shairport Sync May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:55 volumio sudo[1210]: pam_unix(sudo:session): session closed for user root May 05 20:29:55 volumio sudo[1213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 05 20:29:55 volumio sudo[1213]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:55 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 05 20:29:55 volumio volumio[893]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 05 20:29:55 volumio sudo[1205]: pam_unix(sudo:session): session closed for user root May 05 20:29:55 volumio volumio[893]: info: ___________ START PLUGINS ___________ May 05 20:29:55 volumio systemd[1]: Stopping Music Player Daemon... May 05 20:29:55 volumio volumio[893]: info: ControllerMpd::onStart: Initializing MPD May 05 20:29:55 volumio volumio[893]: info: Creating MPD Configuration file May 05 20:29:55 volumio sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 05 20:29:55 volumio sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 05 20:29:55 volumio sudo[1219]: pam_unix(sudo:session): session closed for user root May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 05 20:29:55 volumio volumio[893]: info: [1746451795651] CoreMusicLibrary::Adding element Máy chủ Media May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 20:29:55 volumio sudo[1222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 05 20:29:55 volumio sudo[1222]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:55 volumio systemd[1]: mpd.service: Succeeded. May 05 20:29:55 volumio systemd[1]: Stopped Music Player Daemon. May 05 20:29:55 volumio systemd[1]: Starting Music Player Daemon... May 05 20:29:55 volumio volumio[893]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:55 volumio volumio[893]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 05 20:29:55 volumio volumio[893]: info: [1746451795760] CoreMusicLibrary::Adding element Last_100 May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 05 20:29:55 volumio volumio[893]: info: [1746451795763] CoreMusicLibrary::Adding element Webradio May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 05 20:29:55 volumio volumio[893]: info: Initializing BBC Radios May 05 20:29:55 volumio sudo[1227]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 05 20:29:55 volumio sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:55 volumio sudo[1227]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 05 20:29:55 volumio sudo[1227]: pam_unix(sudo:session): session closed for user root May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:55 volumio volumio[893]: info: Creating Spotify config file May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 05 20:29:55 volumio volumio[893]: info: [1746451795946] CoreMusicLibrary::Adding element YouTube2 May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 20:29:55 volumio volumio[893]: Cannot find translation for source YouTube2 May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 05 20:29:55 volumio volumio[893]: info: [1746451795985] CoreMusicLibrary::Adding element YouTube Music May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 05 20:29:55 volumio volumio[893]: Cannot find translation for source YouTube2 May 05 20:29:55 volumio volumio[893]: Cannot find translation for source YouTube Music May 05 20:29:55 volumio volumio[893]: info: Loading i18n strings for locale vi May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 05 20:29:55 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:55 volumio volumio[893]: info: FusionDsp - mixtype--------------------- Software May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 05 20:29:56 volumio sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh May 05 20:29:56 volumio sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:56 volumio sudo[1246]: pam_unix(sudo:session): session closed for user root May 05 20:29:56 volumio sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service May 05 20:29:56 volumio sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:56 volumio volumio[893]: info: Volumio Calling Home May 05 20:29:56 volumio sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start pirateaudio.service May 05 20:29:56 volumio sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:56 volumio volumio[893]: info: Preparing to generate the ALSA configuration file May 05 20:29:56 volumio systemd[1]: Started Service for using pirate audio display in volumio. May 05 20:29:56 volumio sudo[1252]: pam_unix(sudo:session): session closed for user root May 05 20:29:56 volumio volumio[893]: info: Discovery: adding 02287b29-f760-4c9b-9559-d99aa14cbccb May 05 20:29:56 volumio volumio[893]: info: Discovery: Found device Volumio May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::volumioGetState May 05 20:29:56 volumio volumio[893]: info: CorePlayQueue::getTrack 0 May 05 20:29:56 volumio volumio[893]: info: Discovery: this is already registered, 02287b29-f760-4c9b-9559-d99aa14cbccb May 05 20:29:56 volumio volumio[893]: info: Discovery: Found device Volumio May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::volumioGetState May 05 20:29:56 volumio volumio[893]: info: CorePlayQueue::getTrack 0 May 05 20:29:56 volumio volumio[893]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 05 20:29:56 volumio volumio[893]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 05 20:29:56 volumio volumio[893]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf May 05 20:29:56 volumio volumio[893]: info: Reading ALSA contributions from plugins. May 05 20:29:56 volumio volumio[893]: info: Pirate audio service (daemon) started May 05 20:29:56 volumio volumio[893]: info: [MPD_OLED Plugin] Set execute permissions on /tmp/mpd_oled_plugin.sh May 05 20:29:56 volumio volumio[893]: info: MPD Permissions set May 05 20:29:56 volumio volumio[893]: info: MPD Permissions set May 05 20:29:56 volumio volumio[893]: info: Upmpdcli Daemon Started May 05 20:29:56 volumio volumio[893]: info: Spotify config file written May 05 20:29:56 volumio volumio[893]: info: [MPD_OLED Plugin] tmp script created /tmp/mpd_oled_plugin.sh May 05 20:29:56 volumio volumio[893]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio sudo[1259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service May 05 20:29:56 volumio sudo[1259]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:56 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:56 volumio volumio[893]: info: No need to fix Spotify hosts May 05 20:29:56 volumio systemd[1]: Started go-librespot Daemon. May 05 20:29:56 volumio go-librespot[1265]: Librespot-go daemon starting... May 05 20:29:56 volumio sudo[1259]: pam_unix(sudo:session): session closed for user root May 05 20:29:56 volumio mpd[1233]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 05 20:29:56 volumio mpd[1233]: output: No 'audio_output' defined in config file May 05 20:29:56 volumio volumio[1256]: Traceback (most recent call last): May 05 20:29:56 volumio volumio[1256]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in May 05 20:29:56 volumio volumio[1256]: import ST7789 # v0.0.6 May 05 20:29:56 volumio volumio[1256]: ModuleNotFoundError: No module named 'ST7789' May 05 20:29:56 volumio mpd[1233]: output: Successfully detected a sndio audio device May 05 20:29:56 volumio mpd[1233]: zeroconf: No global port, disabling zeroconf May 05 20:29:56 volumio systemd[1]: Started Music Player Daemon. May 05 20:29:56 volumio sudo[1222]: pam_unix(sudo:session): session closed for user root May 05 20:29:56 volumio sudo[1213]: pam_unix(sudo:session): session closed for user root May 05 20:29:56 volumio systemd[1]: Started MPD OLED Plugin. May 05 20:29:56 volumio sudo[1249]: pam_unix(sudo:session): session closed for user root May 05 20:29:56 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE May 05 20:29:56 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. May 05 20:29:56 volumio volumio[893]: info: [MPD_OLED Plugin] Started mpd_oled_plugin service May 05 20:29:56 volumio volumio[893]: info: Volumio called home May 05 20:29:56 volumio volumio[893]: info: Starting Shairport Sync May 05 20:29:56 volumio volumio[893]: info: Starting Shairport Sync May 05 20:29:56 volumio sudo[1284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 05 20:29:56 volumio sudo[1284]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:56 volumio volumio[893]: info: Starting Shairport Sync May 05 20:29:56 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. May 05 20:29:56 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 1. May 05 20:29:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 05 20:29:56 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. May 05 20:29:56 volumio sudo[1287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 05 20:29:56 volumio sudo[1287]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:56 volumio systemd[1]: Started Service for using pirate audio display in volumio. May 05 20:29:56 volumio volumio[893]: error: MPD error: The expression evaluated to a falsy value: May 05 20:29:56 volumio volumio[893]: assert.ok(self.idling) May 05 20:29:56 volumio volumio[893]: error: The expression evaluated to a falsy value: May 05 20:29:56 volumio volumio[893]: assert.ok(self.idling) May 05 20:29:56 volumio volumio[893]: error: updateQueue error: null May 05 20:29:56 volumio sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 05 20:29:56 volumio sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:56 volumio systemd[1]: shairport-sync.service: Succeeded. May 05 20:29:56 volumio volumio[893]: info: MPD running with PID1233 May 05 20:29:56 volumio volumio[893]: ,establishing connection May 05 20:29:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 05 20:29:56 volumio volumio[893]: info: Asound.conf file unchanged, so no further update is needed May 05 20:29:56 volumio volumio[893]: info: Output device has changed, restarting MPD May 05 20:29:56 volumio go-librespot[1265]: time="2025-05-05T20:29:56+07:00" level=info msg="generated new device id: 0ecc0d299307411f55aabd4f1502c3f7fa1179d2" May 05 20:29:56 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 05 20:29:57 volumio go-librespot[1265]: time="2025-05-05T20:29:57+07:00" level=debug msg="stored credentials found for 31g7rsz36thbvubzlpznvvr37hyi" May 05 20:29:57 volumio sudo[1287]: pam_unix(sudo:session): session closed for user root May 05 20:29:57 volumio sudo[1284]: pam_unix(sudo:session): session closed for user root May 05 20:29:57 volumio sudo[1290]: pam_unix(sudo:session): session closed for user root May 05 20:29:57 volumio sudo[1295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 05 20:29:57 volumio sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:57 volumio volumio[893]: info: Output device has changed, restarting Shairport Sync May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:57 volumio sudo[1295]: pam_unix(sudo:session): session closed for user root May 05 20:29:57 volumio sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 05 20:29:57 volumio sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:57 volumio systemd[1]: Stopping MPD OLED Plugin... May 05 20:29:57 volumio systemd[1]: mpd_oled_plugin.service: Main process exited, code=killed, status=15/TERM May 05 20:29:57 volumio volumio[893]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 05 20:29:57 volumio volumio[893]: info: Preparing to generate the ALSA configuration file May 05 20:29:57 volumio systemd[1]: mpd_oled_plugin.service: Succeeded. May 05 20:29:57 volumio systemd[1]: Stopped MPD OLED Plugin. May 05 20:29:57 volumio systemd[1]: Stopping Music Player Daemon... May 05 20:29:57 volumio volumio[893]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 05 20:29:57 volumio volumio[893]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 05 20:29:57 volumio volumio[893]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf May 05 20:29:57 volumio volumio[893]: info: Reading ALSA contributions from plugins. May 05 20:29:57 volumio systemd[1]: mpd.service: Succeeded. May 05 20:29:57 volumio systemd[1]: Stopped Music Player Daemon. May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::volumioGetState May 05 20:29:57 volumio volumio[893]: info: CorePlayQueue::getTrack 0 May 05 20:29:57 volumio volumio[893]: error: MPD error: Error: write EPIPE May 05 20:29:57 volumio volumio[893]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} May 05 20:29:57 volumio systemd[1]: Starting Music Player Daemon... May 05 20:29:57 volumio volumio[893]: info: MPD Permissions set May 05 20:29:57 volumio volumio[893]: info: Shairport-Sync Started May 05 20:29:57 volumio volumio[893]: Error adding Membership: Error: addMembership EINVAL May 05 20:29:57 volumio volumio[893]: info: Shairport-Sync Started May 05 20:29:57 volumio volumio[893]: error: Upnp client error: Error: This socket has been ended by the other party May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio sudo[1305]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 05 20:29:57 volumio sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:57 volumio sudo[1305]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 05 20:29:57 volumio sudo[1305]: pam_unix(sudo:session): session closed for user root May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::volumioGetState May 05 20:29:57 volumio volumio[893]: info: CorePlayQueue::getTrack 0 May 05 20:29:57 volumio volumio[1209]: Generating RSA private key, 4096 bit long modulus (2 primes) May 05 20:29:57 volumio volumio[893]: info: Starting Shairport Sync May 05 20:29:57 volumio sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 05 20:29:57 volumio go-librespot[1265]: time="2025-05-05T20:29:57+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" May 05 20:29:57 volumio go-librespot[1265]: time="2025-05-05T20:29:57+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" May 05 20:29:57 volumio go-librespot[1265]: time="2025-05-05T20:29:57+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" May 05 20:29:57 volumio sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:57 volumio volumio[893]: info: Asound.conf file unchanged, so no further update is needed May 05 20:29:57 volumio volumio[893]: info: Output device has changed, restarting MPD May 05 20:29:57 volumio go-librespot[1265]: time="2025-05-05T20:29:57+07:00" level=debug msg="zeroconf server listening on port 45445" May 05 20:29:57 volumio volumio[1289]: Traceback (most recent call last): May 05 20:29:57 volumio volumio[1289]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in May 05 20:29:57 volumio volumio[1289]: import ST7789 # v0.0.6 May 05 20:29:57 volumio volumio[1289]: ModuleNotFoundError: No module named 'ST7789' May 05 20:29:57 volumio volumio[893]: info: Output device has changed, restarting Shairport Sync May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 05 20:29:57 volumio sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 05 20:29:57 volumio systemd[1]: shairport-sync.service: Succeeded. May 05 20:29:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 05 20:29:57 volumio sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:57 volumio sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 05 20:29:57 volumio volumio[893]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 05 20:29:57 volumio volumio[893]: info: An error occurred while refreshing Spotify Token Error: Bad Request May 05 20:29:57 volumio sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:57 volumio sudo[1329]: pam_unix(sudo:session): session closed for user root May 05 20:29:57 volumio volumio[893]: info: MPD Permissions set May 05 20:29:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE May 05 20:29:57 volumio sudo[1326]: pam_unix(sudo:session): session closed for user root May 05 20:29:57 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 05 20:29:57 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:57 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 05 20:29:57 volumio systemd[1]: mpd.service: Succeeded. May 05 20:29:57 volumio systemd[1]: Stopped Music Player Daemon. May 05 20:29:57 volumio volumio[893]: info: Shairport-Sync Started May 05 20:29:57 volumio systemd[1]: Starting Music Player Daemon... May 05 20:29:57 volumio volumio[893]: info: Starting Shairport Sync May 05 20:29:57 volumio go-librespot[1265]: time="2025-05-05T20:29:57+07:00" level=debug msg="obtained new client token: AAC3StOZHs06aWIhI8sU6sakxHqbF8K72dbu3r8xXTBliV+mAm/s8sejn+hxuWF0Z9XcK3fsMw1K2bm1Z2RGj+/FWLRRpq97LAu4VtnQ8LGdaXya4Vxx1TIYJ6EDlHy2oOaEEVTz4LyuTaYN3p//5cc4Cha9nnGVQDoEyRtZEfqV9CMj+v+73txXFjp/de3Oqb1TwHdRsYrEYBcFgjyyLTDOy5h43IDQG7eJrdCYAmIzIivHm3wO/41Bv5+U" May 05 20:29:57 volumio sudo[1346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 05 20:29:57 volumio sudo[1346]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 05 20:29:57 volumio systemd[1]: shairport-sync.service: Succeeded. May 05 20:29:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 05 20:29:57 volumio sudo[1343]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 05 20:29:57 volumio sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:57 volumio go-librespot[1265]: time="2025-05-05T20:29:57+07:00" level=info msg="connected to ap-gae2.spotify.com:4070" May 05 20:29:57 volumio sudo[1343]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 05 20:29:57 volumio sudo[1343]: pam_unix(sudo:session): session closed for user root May 05 20:29:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 05 20:29:57 volumio sudo[1346]: pam_unix(sudo:session): session closed for user root May 05 20:29:57 volumio volumio[893]: info: Shairport-Sync Started May 05 20:29:57 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. May 05 20:29:57 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 2. May 05 20:29:57 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. May 05 20:29:57 volumio systemd[1]: Started Service for using pirate audio display in volumio. May 05 20:29:57 volumio go-librespot[1265]: time="2025-05-05T20:29:57+07:00" level=debug msg="completed keyexchange" May 05 20:29:58 volumio volumio[893]: info: camilladsp service started and running in background, instance 1 May 05 20:29:58 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 05 20:29:58 volumio volumio[893]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 05 20:29:58 volumio volumio[893]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json May 05 20:29:58 volumio volumio[893]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 05 20:29:58 volumio volumio[893]: info: FusionDsp loaded May 05 20:29:58 volumio volumio[893]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 05 20:29:58 volumio sudo[1364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 05 20:29:58 volumio sudo[1364]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:58 volumio volumio[893]: info: FusionDsp - Reporting Fusion DSP Enabled May 05 20:29:58 volumio volumio[893]: info: Adding Signal Path Element [object Object] May 05 20:29:58 volumio volumio[893]: info: Adding fusiondspeq DSP Signal Path Element May 05 20:29:58 volumio volumio[893]: info: FusionDsp - ---- installed callbackRead May 05 20:29:58 volumio volumio[893]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 20:29:58 volumio volumio[893]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT May 05 20:29:58 volumio volumio[893]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) May 05 20:29:58 volumio volumio[893]: at onErrorNT (internal/child_process.js:465:16) May 05 20:29:58 volumio volumio[893]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { May 05 20:29:58 volumio volumio[893]: errno: -2, May 05 20:29:58 volumio volumio[893]: code: 'ENOENT', May 05 20:29:58 volumio volumio[893]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', May 05 20:29:58 volumio volumio[893]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', May 05 20:29:58 volumio volumio[893]: spawnargs: [ May 05 20:29:58 volumio volumio[893]: '-p', May 05 20:29:58 volumio volumio[893]: 9876, May 05 20:29:58 volumio volumio[893]: '-o', May 05 20:29:58 volumio volumio[893]: '/tmp/camilladsp.log', May 05 20:29:58 volumio volumio[893]: '-l', May 05 20:29:58 volumio volumio[893]: 'warn', May 05 20:29:58 volumio volumio[893]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' May 05 20:29:58 volumio volumio[893]: ] May 05 20:29:58 volumio volumio[893]: } May 05 20:29:58 volumio volumio[893]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 05 20:29:58 volumio volumio[1351]: Traceback (most recent call last): May 05 20:29:58 volumio volumio[1351]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 13, in May 05 20:29:58 volumio volumio[1351]: import ST7789 # v0.0.6 May 05 20:29:58 volumio volumio[1351]: ModuleNotFoundError: No module named 'ST7789' May 05 20:29:58 volumio systemd[1]: Started FusionDsp Daemon. May 05 20:29:58 volumio systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE May 05 20:29:58 volumio systemd[1]: pirateaudio.service: Failed with result 'exit-code'. May 05 20:29:58 volumio go-librespot[1265]: time="2025-05-05T20:29:58+07:00" level=debug msg="completed challenge" May 05 20:29:58 volumio sudo[1364]: pam_unix(sudo:session): session closed for user root May 05 20:29:58 volumio go-librespot[1265]: time="2025-05-05T20:29:58+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: BadCredentials" May 05 20:29:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 05 20:29:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 05 20:29:58 volumio systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. May 05 20:29:58 volumio systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 3. May 05 20:29:58 volumio systemd[1]: Stopped Service for using pirate audio display in volumio. May 05 20:29:58 volumio systemd[1]: Started Service for using pirate audio display in volumio. May 05 20:29:58 volumio sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-05 20:28 May 05 20:29:58 volumio sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) May 05 20:29:58 volumio mpd[1350]: May 05 20:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg 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="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"