-- Logs begin at Thu 2019-02-14 21:11:58 AEDT, end at Mon 2026-01-26 20:22:31 AEDT. -- Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 20:21:00 volumio volumio[987]: info: Getting Alsa Cards List without I2S DAC Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 26 20:21:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 20:21:29 volumio volumio[987]: info: CoreCommandRouter::volumioNext Jan 26 20:21:29 volumio volumio[987]: info: CoreStateMachine::next Jan 26 20:21:29 volumio volumio[987]: info: CoreStateMachine::stop Jan 26 20:21:29 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 20:21:29 volumio volumio[987]: info: CoreStateMachine::play index undefined Jan 26 20:21:29 volumio volumio[987]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 20:21:29 volumio volumio[987]: info: CorePlayQueue::getTrack 3 Jan 26 20:21:29 volumio volumio[987]: info: CoreStateMachine::startPlaybackTimer Jan 26 20:21:29 volumio volumio[987]: info: CorePlayQueue::getTrack 3 Jan 26 20:21:29 volumio volumio[987]: info: [1769419289993] ControllerSpotify::clearAddPlayTrack Jan 26 20:21:29 volumio volumio[987]: info: Sending Spotify command with payload to local API: /player/play Jan 26 20:21:29 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock Jan 26 20:21:29 volumio volumio[987]: info: CorePlayQueue::getTrackBlock Jan 26 20:21:30 volumio go-librespot[25405]: time="2026-01-26T09:21:30Z" level=debug msg="loading track spotify:track:75SH7qKifZ0Mzl4UFmps31 (paused: false, position: 0ms)" Jan 26 20:21:30 volumio go-librespot[25405]: time="2026-01-26T09:21:30Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jan 26 20:21:30 volumio go-librespot[25405]: time="2026-01-26T09:21:30Z" level=trace msg="emitting websocket event: will_play" Jan 26 20:21:30 volumio volumio[987]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:75SH7qKifZ0Mzl4UFmps31","play_origin":"go-librespot"}} Jan 26 20:21:30 volumio volumio[987]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:75SH7qKifZ0Mzl4UFmps31","play_origin":"go-librespot"}} Jan 26 20:21:30 volumio volumio[987]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:75SH7qKifZ0Mzl4UFmps31","play_origin":"go-librespot"}} Jan 26 20:21:30 volumio go-librespot[25405]: time="2026-01-26T09:21:30Z" level=error msg="failed handling status request" error="failed loading context: failed loading current track (load context): failed creating stream: no playable formats for spotify:track:75SH7qKifZ0Mzl4UFmps31" Jan 26 20:21:30 volumio volumio[987]: error: Failed to send command to Spotify local API: /player/play: Error: Internal Server Error Jan 26 20:21:39 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:21:39 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:21:39 volumio volumio[987]: info: Retrieving Cloud Streaming UI Jan 26 20:21:39 volumio volumio[987]: info: Getting Tidal Cloud Configuration Jan 26 20:21:39 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:21:39 volumio volumio[987]: info: Getting Qobuz Cloud Configuration Jan 26 20:21:39 volumio volumio[987]: info: Asking plugin for UI Config Jan 26 20:21:39 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:21:39 volumio volumio[987]: info: Getting Spotify Cloud Configuration Jan 26 20:21:39 volumio volumio[987]: info: Asking plugin for UI Config Jan 26 20:21:39 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:21:39 volumio volumio[987]: info: Saving Spotify Acccount Jan 26 20:21:39 volumio volumio[987]: info: Got Tidal Cloud Configuration Jan 26 20:21:39 volumio volumio[987]: info: Got it Jan 26 20:21:39 volumio volumio[987]: info: Got it Jan 26 20:21:39 volumio volumio[987]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 26 20:21:39 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:21:39 volumio volumio[987]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::volumioGetBrowseSources Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 20:21:40 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 26 20:21:44 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 20:21:48 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 20:21:52 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 20:21:56 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 20:22:00 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 20:22:04 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 26 20:22:14 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:14 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 26 20:22:14 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 26 20:22:14 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 26 20:22:14 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jan 26 20:22:14 volumio volumio[987]: info: Received Get System Version Jan 26 20:22:14 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 26 20:22:26 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Jan 26 20:22:26 volumio volumio[987]: info: CoreCommandRouter::Reload Ui Jan 26 20:22:27 volumio sudo[26382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 26 20:22:27 volumio sudo[26382]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:27 volumio sudo[26384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 26 20:22:27 volumio sudo[26384]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:27 volumio sudo[26384]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:27 volumio sudo[26382]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:27 volumio volumio[987]: verbose: New Socket.io Connection to 192.168.0.90 from 192.168.0.98 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Jan 26 20:22:27 volumio volumio[987]: info: Received Get System Info Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 20:22:27 volumio volumio[987]: info: Discovery: Getting this device information Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Jan 26 20:22:27 volumio volumio[987]: info: CorePlayQueue::getTrack 3 Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 20:22:27 volumio volumio-remote-updater[596]: No test mode Jan 26 20:22:27 volumio volumio-remote-updater[596]: No alpha test mode Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:27 volumio volumio[987]: info: Retrieving Cloud Streaming UI Jan 26 20:22:27 volumio volumio[987]: info: Getting Tidal Cloud Configuration Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:27 volumio volumio[987]: info: Getting Qobuz Cloud Configuration Jan 26 20:22:27 volumio volumio[987]: info: Asking plugin for UI Config Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:27 volumio volumio[987]: info: Getting Spotify Cloud Configuration Jan 26 20:22:27 volumio volumio[987]: info: Asking plugin for UI Config Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:27 volumio volumio[987]: info: Saving Spotify Acccount Jan 26 20:22:27 volumio volumio[987]: info: Got Tidal Cloud Configuration Jan 26 20:22:27 volumio volumio[987]: info: Got it Jan 26 20:22:27 volumio volumio[987]: info: Got it Jan 26 20:22:27 volumio volumio[987]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 26 20:22:27 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:27 volumio volumio[987]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jan 26 20:22:27 volumio volumio[987]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::volumioGetVisibleSources Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Jan 26 20:22:28 volumio volumio[987]: info: Received Get System Info Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 26 20:22:28 volumio volumio[987]: info: Discovery: Getting this device information Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::volumioGetState Jan 26 20:22:28 volumio volumio[987]: info: CorePlayQueue::getTrack 3 Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 26 20:22:28 volumio volumio-remote-updater[596]: No test mode Jan 26 20:22:28 volumio volumio-remote-updater[596]: No alpha test mode Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:28 volumio volumio[987]: info: Retrieving Cloud Streaming UI Jan 26 20:22:28 volumio volumio[987]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 26 20:22:28 volumio volumio[987]: info: Getting Tidal Cloud Configuration Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:28 volumio volumio[987]: info: Getting Qobuz Cloud Configuration Jan 26 20:22:28 volumio volumio[987]: info: Asking plugin for UI Config Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:28 volumio volumio[987]: info: Getting Spotify Cloud Configuration Jan 26 20:22:28 volumio volumio[987]: info: Asking plugin for UI Config Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:28 volumio volumio[987]: info: Saving Spotify Acccount Jan 26 20:22:28 volumio volumio[987]: info: Got Tidal Cloud Configuration Jan 26 20:22:28 volumio volumio[987]: info: Got it Jan 26 20:22:28 volumio volumio[987]: info: Got it Jan 26 20:22:28 volumio volumio[987]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 20:22:28 volumio volumio[987]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jan 26 20:22:28 volumio volumio[987]: info: Loading i18n strings for locale en Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jan 26 20:22:28 volumio volumio[987]: info: Setting timezone to Australia/Melbourne Jan 26 20:22:28 volumio sudo[26400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jan 26 20:22:28 volumio sudo[26400]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:28 volumio sudo[26400]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:28 volumio sudo[26403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Australia/Melbourne /etc/localtime Jan 26 20:22:28 volumio sudo[26403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:28 volumio sudo[26403]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:28 volumio sudo[26406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jan 26 20:22:28 volumio sudo[26406]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:28 volumio sudo[26406]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:28 volumio sudo[26409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Australia/Melbourne Jan 26 20:22:28 volumio sudo[26409]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:28 volumio dbus-daemon[632]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.23' (uid=0 pid=26410 comm="/usr/bin/timedatectl set-timezone Australia/Melbou") Jan 26 20:22:28 volumio systemd[1]: Starting Time & Date Service... Jan 26 20:22:28 volumio dbus-daemon[632]: [system] Successfully activated service 'org.freedesktop.timedate1' Jan 26 20:22:28 volumio systemd[1]: Started Time & Date Service. Jan 26 20:22:28 volumio sudo[26409]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:28 volumio volumio[987]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 26 20:22:28 volumio volumio[987]: Updating browse sources language Jan 26 20:22:28 volumio volumio[987]: Cannot find translation for source Spotify Jan 26 20:22:28 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 20:22:28 volumio volumio[987]: Cannot find translation for source Spotify Jan 26 20:22:29 volumio volumio[987]: info: Fetching Streaming Services browse cache Jan 26 20:22:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 20:22:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 20:22:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 26 20:22:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jan 26 20:22:29 volumio volumio[987]: info: Loading i18n strings for locale en Jan 26 20:22:29 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jan 26 20:22:29 volumio volumio[987]: info: Setting timezone to UTC Jan 26 20:22:29 volumio sudo[26413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jan 26 20:22:29 volumio sudo[26413]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:29 volumio sudo[26413]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:29 volumio sudo[26416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/UTC /etc/localtime Jan 26 20:22:29 volumio sudo[26416]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:29 volumio sudo[26416]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:29 volumio sudo[26419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jan 26 20:22:29 volumio sudo[26419]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:29 volumio sudo[26419]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:30 volumio sudo[26422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC Jan 26 20:22:30 volumio sudo[26422]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:30 volumio systemd-timedated[26411]: Failed to set time zone: Permission denied Jan 26 20:22:30 volumio sudo[26422]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:30 volumio volumio[987]: Failed to set time zone: Access denied Jan 26 20:22:30 volumio volumio[987]: info: Could not set timezone, retrying Jan 26 20:22:30 volumio volumio[987]: Updating browse sources language Jan 26 20:22:30 volumio volumio[987]: Cannot find translation for source Spotify Jan 26 20:22:30 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 20:22:30 volumio volumio[987]: Cannot find translation for source Spotify Jan 26 20:22:30 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jan 26 20:22:30 volumio volumio[987]: info: Loading i18n strings for locale en Jan 26 20:22:30 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jan 26 20:22:30 volumio volumio[987]: info: Setting timezone to Australia/Melbourne Jan 26 20:22:30 volumio sudo[26425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jan 26 20:22:30 volumio sudo[26425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:30 volumio sudo[26425]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:30 volumio sudo[26428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Australia/Melbourne /etc/localtime Jan 26 20:22:30 volumio sudo[26428]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:30 volumio sudo[26428]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:30 volumio sudo[26431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jan 26 20:22:30 volumio sudo[26431]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:30 volumio sudo[26431]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:30 volumio sudo[26434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Australia/Melbourne Jan 26 20:22:30 volumio sudo[26434]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:30 volumio systemd-timedated[26411]: Failed to set time zone: Permission denied Jan 26 20:22:30 volumio sudo[26434]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:30 volumio volumio[987]: Failed to set time zone: Access denied Jan 26 20:22:30 volumio volumio[987]: info: Could not set timezone, retrying Jan 26 20:22:30 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jan 26 20:22:30 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jan 26 20:22:30 volumio volumio[987]: info: Fetching Streaming Services browse cache Jan 26 20:22:30 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 26 20:22:30 volumio sudo[26437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 26 20:22:30 volumio sudo[26437]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:30 volumio volumio[987]: Updating browse sources language Jan 26 20:22:30 volumio volumio[987]: Cannot find translation for source Spotify Jan 26 20:22:30 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 26 20:22:30 volumio volumio[987]: Cannot find translation for source Spotify Jan 26 20:22:30 volumio volumio[987]: info: Fetching Streaming Services browse cache Jan 26 20:22:31 volumio sudo[26440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone UTC Jan 26 20:22:31 volumio sudo[26440]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 20:22:31 volumio systemd-timedated[26411]: Failed to set time zone: Permission denied Jan 26 20:22:31 volumio sudo[26440]: pam_unix(sudo:session): session closed for user root Jan 26 20:22:31 volumio volumio[987]: Failed to set time zone: Access denied Jan 26 20:22:31 volumio volumio[987]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 20:22:31 volumio volumio[987]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'UTC' Jan 26 20:22:31 volumio volumio[987]: Failed to set time zone: Access denied Jan 26 20:22:31 volumio volumio[987]: at checkExecSyncError (child_process.js:616:11) Jan 26 20:22:31 volumio volumio[987]: at execSync (child_process.js:652:15) Jan 26 20:22:31 volumio volumio[987]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1680:9) Jan 26 20:22:31 volumio volumio[987]: at listOnTimeout (internal/timers.js:554:17) Jan 26 20:22:31 volumio volumio[987]: at processTimers (internal/timers.js:497:7) { Jan 26 20:22:31 volumio volumio[987]: status: 1, Jan 26 20:22:31 volumio volumio[987]: signal: null, Jan 26 20:22:31 volumio volumio[987]: output: [ null, '', 'Failed to set time zone: Access denied\n' ], Jan 26 20:22:31 volumio volumio[987]: pid: 26439, Jan 26 20:22:31 volumio volumio[987]: stdout: '', Jan 26 20:22:31 volumio volumio[987]: stderr: 'Failed to set time zone: Access denied\n' Jan 26 20:22:31 volumio volumio[987]: } Jan 26 20:22:31 volumio volumio[987]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 20:22:31 volumio sudo[26451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-26 20:21 Jan 26 20:22:31 volumio sudo[26451]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"