-- Logs begin at Wed 2024-10-16 16:37:26 CST, end at Wed 2024-10-16 16:40:41 CST. --
Oct 16 16:39:46 volumio login[681]: pam_unix(login:session): session opened for user volumio by LOGIN(uid=0)
Oct 16 16:39:46 volumio systemd[1]: Created slice User Slice of UID 1000.
Oct 16 16:39:46 volumio systemd[1]: Starting User Runtime Directory /run/user/1000...
Oct 16 16:39:46 volumio systemd-logind[314]: New session 1 of user volumio.
Oct 16 16:39:46 volumio systemd[1]: Started User Runtime Directory /run/user/1000.
Oct 16 16:39:46 volumio systemd[1]: Starting User Manager for UID 1000...
Oct 16 16:39:46 volumio systemd[2198]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0)
Oct 16 16:39:46 volumio systemd[2198]: gpgconf: running /usr/bin/gpg-agent failed (exitcode=2): General error
Oct 16 16:39:46 volumio systemd[2198]: gpgconf: fatal error (exit status 1)
Oct 16 16:39:46 volumio systemd[2198]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Oct 16 16:39:46 volumio systemd[2198]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Oct 16 16:39:46 volumio systemd[2198]: Reached target Paths.
Oct 16 16:39:46 volumio systemd[2198]: Reached target Timers.
Oct 16 16:39:46 volumio systemd[2198]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Oct 16 16:39:46 volumio systemd[2198]: Starting D-Bus User Message Bus Socket.
Oct 16 16:39:46 volumio systemd[2198]: Listening on GnuPG cryptographic agent and passphrase cache.
Oct 16 16:39:46 volumio systemd[2198]: Listening on GnuPG network certificate management daemon.
Oct 16 16:39:46 volumio systemd[2198]: Listening on Sound System.
Oct 16 16:39:46 volumio systemd[2198]: Listening on D-Bus User Message Bus Socket.
Oct 16 16:39:46 volumio systemd[2198]: Reached target Sockets.
Oct 16 16:39:46 volumio systemd[2198]: Reached target Basic System.
Oct 16 16:39:46 volumio systemd[1]: Started User Manager for UID 1000.
Oct 16 16:39:46 volumio systemd[2198]: Starting Music Player Daemon...
Oct 16 16:39:46 volumio systemd[1]: Started Session 1 of user volumio.
Oct 16 16:39:47 volumio mpd[2209]: exception: failed to open log file "/var/log/mpd.log" (config line 7): Permission denied
Oct 16 16:39:47 volumio systemd[2198]: mpd.service: Main process exited, code=exited, status=1/FAILURE
Oct 16 16:39:47 volumio systemd[2198]: mpd.service: Failed with result 'exit-code'.
Oct 16 16:39:47 volumio systemd[2198]: Failed to start Music Player Daemon.
Oct 16 16:39:47 volumio systemd[2198]: Reached target Default.
Oct 16 16:39:47 volumio systemd[2198]: Startup finished in 1.556s.
Oct 16 16:39:57 volumio sudo[2214]:  volumio : TTY=ttyFIQ0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl status volumio.service
Oct 16 16:39:57 volumio sudo[2214]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Oct 16 16:40:04 volumio sudo[2214]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:06 volumio sudo[2217]:  volumio : TTY=ttyFIQ0 ; PWD=/home/volumio ; USER=root ; COMMAND=/sbin/ifconfig
Oct 16 16:40:06 volumio sudo[2217]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Oct 16 16:40:06 volumio sudo[2217]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:20 volumio sudo[2221]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 16 16:40:20 volumio sudo[2221]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:20 volumio sudo[2221]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:20 volumio sudo[2223]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 16 16:40:20 volumio sudo[2223]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:20 volumio sudo[2223]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:20 volumio volumio[755]: verbose: New Socket.io Connection to 192.168.1.240 from 192.168.1.11 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/129.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Oct 16 16:40:20 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Oct 16 16:40:20 volumio volumio[755]: info: Received Get System Info
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 16 16:40:20 volumio volumio[755]: info: Discovery: Getting this device information
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::volumioGetState
Oct 16 16:40:20 volumio volumio[755]: info: CorePlayQueue::getTrack 0
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 16 16:40:20 volumio volumio-remote-updater[323]: No test mode
Oct 16 16:40:20 volumio volumio-remote-updater[323]: No alpha test mode
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:20 volumio volumio[755]: info: Retrieving Cloud Streaming UI
Oct 16 16:40:20 volumio volumio[755]: info: Getting Tidal Cloud Configuration
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:20 volumio volumio[755]: info: Getting Qobuz Cloud Configuration
Oct 16 16:40:20 volumio volumio[755]: info: Asking plugin for UI Config
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:20 volumio volumio[755]: info: Getting Spotify Cloud Configuration
Oct 16 16:40:20 volumio volumio[755]: info: Asking plugin for UI Config
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:20 volumio volumio[755]: info: Saving Spotify Acccount
Oct 16 16:40:20 volumio volumio[755]: info: Got Tidal Cloud Configuration
Oct 16 16:40:20 volumio volumio[755]: info: Got it
Oct 16 16:40:20 volumio volumio[755]: info: Got it
Oct 16 16:40:20 volumio volumio[755]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Oct 16 16:40:20 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:20 volumio volumio[755]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Oct 16 16:40:21 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Oct 16 16:40:21 volumio volumio[755]: info: Loading i18n strings for locale zh
Oct 16 16:40:21 volumio volumio[755]: Updating browse sources language
Oct 16 16:40:21 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 16 16:40:21 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Oct 16 16:40:21 volumio volumio[755]: info: Setting timezone to Asia/Shanghai
Oct 16 16:40:21 volumio sudo[2233]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Oct 16 16:40:21 volumio sudo[2233]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:21 volumio sudo[2233]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:21 volumio sudo[2236]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime
Oct 16 16:40:21 volumio sudo[2236]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:21 volumio sudo[2236]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:21 volumio sudo[2239]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Oct 16 16:40:21 volumio sudo[2239]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:21 volumio sudo[2239]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:21 volumio sudo[2242]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai
Oct 16 16:40:21 volumio sudo[2242]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:21 volumio dbus-daemon[301]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.13' (uid=0 pid=2243 comm="/usr/bin/timedatectl set-timezone Asia/Shanghai ")
Oct 16 16:40:21 volumio systemd[1]: Starting Time & Date Service...
Oct 16 16:40:22 volumio dbus-daemon[301]: [system] Successfully activated service 'org.freedesktop.timedate1'
Oct 16 16:40:22 volumio systemd[1]: Started Time & Date Service.
Oct 16 16:40:22 volumio sudo[2242]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:22 volumio volumio[755]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nImproved translations
\nFix for Wizard not showing on second start 
\nFix for Playback Queue not advancing
\nAdd bootdelay for fixing factory-reset from USB on StreamPlay
\n
\nNEW ADDITIONS
\n\nAdd DSD Quirk for Marantz SA-12 on Rivo and Primo v2
\n\n","title":"Update v3.757","updateavailable":true}
Oct 16 16:40:22 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 16 16:40:22 volumio volumio[755]: info: Fetching Streaming Services browse cache
Oct 16 16:40:22 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 16 16:40:22 volumio volumio[755]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/miscellanea/appearance/config.json'
Oct 16 16:40:22 volumio volumio[755]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/system/config.json'
Oct 16 16:40:22 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Oct 16 16:40:22 volumio volumio[755]: info: Loading i18n strings for locale zh
Oct 16 16:40:22 volumio volumio[755]: Updating browse sources language
Oct 16 16:40:22 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 16 16:40:22 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Oct 16 16:40:22 volumio volumio[755]: info: Setting timezone to Asia/Shanghai
Oct 16 16:40:22 volumio sudo[2246]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Oct 16 16:40:22 volumio sudo[2246]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:22 volumio sudo[2246]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:23 volumio sudo[2249]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime
Oct 16 16:40:23 volumio sudo[2249]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:23 volumio sudo[2249]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:23 volumio sudo[2252]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Oct 16 16:40:23 volumio sudo[2252]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:23 volumio sudo[2252]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:23 volumio sudo[2255]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai
Oct 16 16:40:23 volumio sudo[2255]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:23 volumio sudo[2255]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:23 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Oct 16 16:40:23 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Oct 16 16:40:23 volumio sudo[2258]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 16 16:40:23 volumio sudo[2258]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:23 volumio sudo[2258]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:23 volumio volumio[755]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Oct 16 16:40:23 volumio volumio[755]: wlan0     Interface doesn't support scanning.
Oct 16 16:40:23 volumio volumio[755]: info: Cannot use regular scanning, forcing with ap-force
Oct 16 16:40:23 volumio sudo[2263]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Oct 16 16:40:23 volumio sudo[2263]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:23 volumio sudo[2263]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:23 volumio volumio[755]: command failed: No such device (-19)
Oct 16 16:40:23 volumio volumio[755]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Oct 16 16:40:23 volumio volumio[755]: command failed: No such device (-19)
Oct 16 16:40:23 volumio volumio[755]: info: Fetching Streaming Services browse cache
Oct 16 16:40:23 volumio volumio[755]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/miscellanea/appearance/config.json'
Oct 16 16:40:24 volumio volumio[755]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/system/config.json'
Oct 16 16:40:28 volumio volumio[755]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object]
Oct 16 16:40:28 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings
Oct 16 16:40:28 volumio volumio[755]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined
Oct 16 16:40:29 volumio volumio[755]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object]
Oct 16 16:40:29 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings
Oct 16 16:40:29 volumio volumio[755]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined
Oct 16 16:40:29 volumio volumio[755]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/system/config.json'
Oct 16 16:40:34 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
Oct 16 16:40:34 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices
Oct 16 16:40:34 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:34 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 16 16:40:34 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:40:34 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 16 16:40:36 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Oct 16 16:40:36 volumio volumio[755]: info: Preparing to save Alsa Options, stopping services first
Oct 16 16:40:36 volumio volumio[755]: info: CoreCommandRouter::volumioGetState
Oct 16 16:40:36 volumio volumio[755]: info: CorePlayQueue::getTrack 0
Oct 16 16:40:36 volumio volumio[755]: info: CoreCommandRouter::volumioPause
Oct 16 16:40:36 volumio volumio[755]: info: CoreStateMachine::pause
Oct 16 16:40:36 volumio volumio[755]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0","label":"Combo384 Amanero"},"disallowPush":true}
Oct 16 16:40:36 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 16 16:40:36 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:36 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:36 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 16 16:40:36 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:36 volumio volumio[755]: info: Setting mixer PCM for card Combo384 Amanero
Oct 16 16:40:36 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:36 volumio volumio[755]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 16 16:40:36 volumio volumio[755]: info: Updating Volume Controller Parameters: Device: 0 Name: Combo384 Amanero Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 16 16:40:36 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 16 16:40:36 volumio volumio[755]: info: Disabling external Volume Control
Oct 16 16:40:36 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:36 volumio volumio[755]: info: Preparing to generate the ALSA configuration file
Oct 16 16:40:36 volumio volumio[755]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Home directory not accessible: Permission denied
Oct 16 16:40:36 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:36 volumio volumio[755]: info: Retrieving Cloud Streaming UI
Oct 16 16:40:37 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 16 16:40:37 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 16 16:40:37 volumio volumio[755]: error: Cannot write /etc/asound.conf: Error: EACCES: permission denied, open '/home/volumio/.asoundrc'
Oct 16 16:40:37 volumio volumio[755]: info: Output device has changed, restarting MPD
Oct 16 16:40:37 volumio sudo[2320]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 16 16:40:37 volumio sudo[2320]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:37 volumio volumio[755]: info: Output device has changed, restarting Shairport Sync
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:40:37 volumio sudo[2320]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:37 volumio sudo[2323]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 16 16:40:37 volumio sudo[2323]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:37 volumio systemd[1]: Stopping Music Player Daemon...
Oct 16 16:40:37 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:37 volumio volumio[755]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 16 16:40:37 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:37 volumio volumio[755]: info: VolumeController:: Volume=undefined Mute =false
Oct 16 16:40:37 volumio systemd[1]: mpd.service: Succeeded.
Oct 16 16:40:37 volumio volumio[755]: info: CoreStateMachine::pushState
Oct 16 16:40:37 volumio volumio[755]: info: CorePlayQueue::getTrack 0
Oct 16 16:40:37 volumio systemd[1]: Stopped Music Player Daemon.
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::volumioPushState
Oct 16 16:40:37 volumio systemd[1]: Starting Music Player Daemon...
Oct 16 16:40:37 volumio volumio[755]: info: MPD Permissions set
Oct 16 16:40:37 volumio volumio[755]: info: Getting Tidal Cloud Configuration
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:37 volumio volumio[755]: info: Getting Qobuz Cloud Configuration
Oct 16 16:40:37 volumio volumio[755]: info: Asking plugin for UI Config
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:37 volumio volumio[755]: info: Getting Spotify Cloud Configuration
Oct 16 16:40:37 volumio volumio[755]: info: Asking plugin for UI Config
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:37 volumio volumio[755]: info: Saving Spotify Acccount
Oct 16 16:40:37 volumio volumio[755]: info: Got Tidal Cloud Configuration
Oct 16 16:40:37 volumio volumio[755]: info: Got it
Oct 16 16:40:37 volumio volumio[755]: info: Got it
Oct 16 16:40:37 volumio volumio[755]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 16 16:40:37 volumio volumio[755]: info: Starting Shairport Sync
Oct 16 16:40:37 volumio sudo[2328]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 16 16:40:37 volumio sudo[2328]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:37 volumio sudo[2328]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:37 volumio volumio[755]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 16 16:40:37 volumio volumio[755]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Oct 16 16:40:37 volumio sudo[2338]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 16 16:40:37 volumio sudo[2338]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 16 16:40:37 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 16 16:40:37 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 16 16:40:37 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 16 16:40:37 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 16 16:40:37 volumio sudo[2338]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:37 volumio volumio[755]: info: Shairport-Sync Started
Oct 16 16:40:37 volumio volumio[755]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/audio_interface/alsa_controller/config.json'
Oct 16 16:40:38 volumio mpd[2337]: Oct 16 16:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 16 16:40:38 volumio systemd[1]: Started Music Player Daemon.
Oct 16 16:40:38 volumio sudo[2323]: pam_unix(sudo:session): session closed for user root
Oct 16 16:40:38 volumio volumio[755]: error: updateQueue error: null
Oct 16 16:40:39 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation
Oct 16 16:40:39 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware
Oct 16 16:40:39 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:39 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray
Oct 16 16:40:39 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage
Oct 16 16:40:39 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware
Oct 16 16:40:39 volumio volumio[755]: Home directory not accessible: Permission denied
Oct 16 16:40:40 volumio volumio[755]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction
Oct 16 16:40:40 volumio volumio[755]: /bin/rm: cannot remove '/data/wizard': Permission denied
Oct 16 16:40:40 volumio volumio[755]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 16 16:40:40 volumio volumio[755]: Error: Command failed: /bin/rm -f /data/wizard
Oct 16 16:40:40 volumio volumio[755]: /bin/rm: cannot remove '/data/wizard': Permission denied
Oct 16 16:40:40 volumio volumio[755]:     at checkExecSyncError (child_process.js:790:11)
Oct 16 16:40:40 volumio volumio[755]:     at execSync (child_process.js:863:15)
Oct 16 16:40:40 volumio volumio[755]:     at volumioWizard.setCloseWizard (/volumio/app/plugins/miscellanea/wizard/index.js:304:3)
Oct 16 16:40:40 volumio volumio[755]:     at volumioWizard.setWizardAction (/volumio/app/plugins/miscellanea/wizard/index.js:266:14)
Oct 16 16:40:40 volumio volumio[755]:     at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1083:32)
Oct 16 16:40:40 volumio volumio[755]:     at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1614:33)
Oct 16 16:40:40 volumio volumio[755]:     at Socket.emit (events.js:400:28)
Oct 16 16:40:40 volumio volumio[755]:     at /volumio/node_modules/socket.io/lib/socket.js:528:12
Oct 16 16:40:40 volumio volumio[755]:     at processTicksAndRejections (internal/process/task_queues.js:77:11) {
Oct 16 16:40:40 volumio volumio[755]:   status: 1,
Oct 16 16:40:40 volumio volumio[755]:   signal: null,
Oct 16 16:40:40 volumio volumio[755]:   output: [
Oct 16 16:40:40 volumio volumio[755]:     null,
Oct 16 16:40:40 volumio volumio[755]:     ,
Oct 16 16:40:40 volumio volumio[755]:     
Oct 16 16:40:40 volumio volumio[755]:   ],
Oct 16 16:40:40 volumio volumio[755]:   pid: 2351,
Oct 16 16:40:40 volumio volumio[755]:   stdout: ,
Oct 16 16:40:40 volumio volumio[755]:   stderr: 
Oct 16 16:40:40 volumio volumio[755]: }
Oct 16 16:40:40 volumio volumio[755]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 16 16:40:41 volumio sudo[2362]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-16 16:39
Oct 16 16:40:41 volumio sudo[2362]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="6e682b9410d28f3874f90b2d7789db824a859264"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="218f986668198768ef5630191ffb17431779722f"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Jun 2024 10:07:52 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="odroidm1s"
VOLUMIO_DEVICENAME="Odroid M1S"
VOLUMIO_HASH="8e8313fb3db92f972e3c67e9a9aee148"