-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Thu 2025-06-12 20:36:23 CEST. -- Jun 12 20:35:14 volumio-1 sudo[13581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 12 20:35:14 volumio-1 sudo[13581]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:35:14 volumio-1 sudo[13581]: pam_unix(sudo:session): session closed for user root Jun 12 20:35:14 volumio-1 sudo[13583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 12 20:35:14 volumio-1 sudo[13583]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:35:14 volumio-1 sudo[13583]: pam_unix(sudo:session): session closed for user root Jun 12 20:35:14 volumio-1 volumio[898]: verbose: New Socket.io Connection to 192.168.1.51 from 192.168.1.15 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.5 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 8 Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetVisibleSources Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 12 20:35:14 volumio-1 volumio[898]: info: Received Get System Info Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 20:35:14 volumio-1 volumio[898]: info: Discovery: Getting this device information Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:35:14 volumio-1 volumio[898]: info: Listing playlists Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 12 20:35:14 volumio-1 sudo[13587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 12 20:35:14 volumio-1 sudo[13587]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:35:14 volumio-1 sudo[13587]: pam_unix(sudo:session): session closed for user root Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 12 20:35:14 volumio-1 sudo[13590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 12 20:35:14 volumio-1 sudo[13590]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:35:14 volumio-1 sudo[13590]: pam_unix(sudo:session): session closed for user root Jun 12 20:35:14 volumio-1 volumio[898]: verbose: New Socket.io Connection to 192.168.1.51 from 192.168.1.15 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.5 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 8 Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetVisibleSources Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 12 20:35:14 volumio-1 volumio[898]: info: Received Get System Info Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 20:35:14 volumio-1 volumio[898]: info: Discovery: Getting this device information Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:35:14 volumio-1 volumio[898]: info: Listing playlists Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 12 20:35:14 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 12 20:35:16 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 12 20:35:16 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 12 20:35:16 volumio-1 volumio[898]: info: Received Get System Info Jun 12 20:35:16 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 20:35:16 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 20:35:16 volumio-1 volumio[898]: info: Discovery: Getting this device information Jun 12 20:35:16 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:35:16 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 20:35:16 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 12 20:35:24 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 12 20:35:30 volumio-1 volumio-remote-updater[619]: No test mode Jun 12 20:35:30 volumio-1 volumio-remote-updater[619]: No alpha test mode Jun 12 20:35:30 volumio-1 volumio[898]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES



 

","title":"Update v3.816","updateavailable":true} Jun 12 20:35:30 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 12 20:35:32 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 12 20:35:32 volumio-1 volumio[898]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 12 20:35:32 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 12 20:35:32 volumio-1 volumio[898]: info: Received Get System Version Jun 12 20:35:32 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 12 20:35:32 volumio-1 volumio[898]: info: Received Get System Info Jun 12 20:35:32 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 20:35:32 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 20:35:32 volumio-1 volumio[898]: info: Discovery: Getting this device information Jun 12 20:35:32 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:35:32 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 20:35:37 volumio-1 volumio[898]: info: CoreCommandRouter::Close All Modals sent Jun 12 20:35:39 volumio-1 volumio[898]: info: CoreCommandRouter::volumioGetQueue Jun 12 20:35:39 volumio-1 volumio[898]: info: CoreStateMachine::getQueue Jun 12 20:35:39 volumio-1 volumio[898]: info: CorePlayQueue::getQueue Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::volumioStop Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreStateMachine::stop Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreStateMachine::stPlaybackTimer Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreStateMachine::updateTrackBlock Jun 12 20:35:44 volumio-1 volumio[898]: info: CorePlayQueue::getTrackBlock Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreStateMachine::pushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::volumioPushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreStateMachine::serviceStop Jun 12 20:35:44 volumio-1 volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::serviceStop Jun 12 20:35:44 volumio-1 volumio[898]: info: [1749753344025] ControllerWebradio::stop Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::sendMpdCommand stop Jun 12 20:35:44 volumio-1 volumio[898]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Jun 12 20:35:44 volumio-1 volumio[898]: info: Jun 12 20:35:44 volumio-1 volumio[898]: ---------------------------- MPD announces state update: player Jun 12 20:35:44 volumio-1 volumio[898]: info: sendMpdCommand stop took 30 milliseconds Jun 12 20:35:44 volumio-1 volumio[898]: info: ControllerMpd::getState Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Jun 12 20:35:44 volumio-1 volumio[898]: info: Jun 12 20:35:44 volumio-1 volumio[898]: ---------------------------- MPD announces state update: player Jun 12 20:35:44 volumio-1 volumio[898]: info: ControllerMpd::getState Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Jun 12 20:35:44 volumio-1 volumio[898]: info: Jun 12 20:35:44 volumio-1 volumio[898]: ---------------------------- MPD announces state update: player Jun 12 20:35:44 volumio-1 volumio[898]: info: ControllerMpd::getState Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::sendMpdCommand status Jun 12 20:35:44 volumio-1 volumio[898]: info: sendMpdCommand status took 2 milliseconds Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::parseState Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 20:35:44 volumio-1 volumio[898]: info: sendMpdCommand status took 3 milliseconds Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::parseState Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 20:35:44 volumio-1 volumio[898]: info: sendMpdCommand status took 10 milliseconds Jun 12 20:35:44 volumio-1 volumio[898]: info: sendMpdCommand playlistinfo took 10 milliseconds Jun 12 20:35:44 volumio-1 volumio[898]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::parseState Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::parseTrackInfo Jun 12 20:35:44 volumio-1 volumio[898]: info: ControllerMpd::pushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::servicePushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreStateMachine::pushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::volumioPushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:35:44 volumio-1 volumio[898]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jun 12 20:35:44 volumio-1 volumio[898]: info: ControllerMpd::pushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::servicePushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreStateMachine::pushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::volumioPushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:35:44 volumio-1 volumio[898]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jun 12 20:35:44 volumio-1 volumio[898]: info: ------------------------------ 30ms Jun 12 20:35:44 volumio-1 volumio[898]: info: sendMpdCommand playlistinfo took 17 milliseconds Jun 12 20:35:44 volumio-1 volumio[898]: verbose: ControllerMpd::parseTrackInfo Jun 12 20:35:44 volumio-1 volumio[898]: info: ControllerMpd::pushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::servicePushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreStateMachine::pushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:35:44 volumio-1 volumio[898]: info: CoreCommandRouter::volumioPushState Jun 12 20:35:44 volumio-1 volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:35:44 volumio-1 volumio[898]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jun 12 20:35:44 volumio-1 volumio[898]: info: ------------------------------ 36ms Jun 12 20:35:44 volumio-1 volumio[898]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Jun 12 20:35:44 volumio-1 volumio[898]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Jun 12 20:35:44 volumio-1 volumio[898]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Jun 12 20:35:44 volumio-1 volumio[898]: info: touch_display: Setting screensaver timeout to 120 seconds. Jun 12 20:35:51 volumio-1 volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 20:35:51 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 12 20:35:51 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 12 20:35:51 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 12 20:35:51 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jun 12 20:35:51 volumio-1 volumio[898]: info: Received Get System Version Jun 12 20:35:51 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 12 20:36:06 volumio-1 volumio[898]: info: CALLMETHOD: system_controller system saveGeneralSettings [object Object] Jun 12 20:36:06 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Jun 12 20:36:06 volumio-1 volumio[898]: info: System name has changed, restarting Shairport Sync Jun 12 20:36:06 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 12 20:36:06 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 12 20:36:06 volumio-1 volumio[898]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 12 20:36:06 volumio-1 volumio[898]: info: Updating MyVolumio device info Jun 12 20:36:06 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 12 20:36:06 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 12 20:36:06 volumio-1 volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 12 20:36:06 volumio-1 volumio[898]: info: Discovery: Restarting Advertising due to device name change Jun 12 20:36:06 volumio-1 sudo[13802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jun 12 20:36:06 volumio-1 sudo[13802]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:06 volumio-1 sudo[13802]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:06 volumio-1 volumio[898]: info: Starting Shairport Sync Jun 12 20:36:06 volumio-1 systemd[1]: upmpdcli.service: Succeeded. Jun 12 20:36:06 volumio-1 sudo[13805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Jun 12 20:36:06 volumio-1 sudo[13805]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:06 volumio-1 sudo[13805]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:06 volumio-1 volumio[898]: info: Permissions for /etc/hosts set Jun 12 20:36:06 volumio-1 sudo[13810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 12 20:36:06 volumio-1 sudo[13810]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:06 volumio-1 volumio[898]: info: Hostname now is volumio-altanok Jun 12 20:36:06 volumio-1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 12 20:36:06 volumio-1 systemd[1]: shairport-sync.service: Succeeded. Jun 12 20:36:06 volumio-1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 12 20:36:06 volumio-1 sudo[13813]: volumio : unable to resolve host volumio-1 Jun 12 20:36:06 volumio-1 sudo[13813]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jun 12 20:36:06 volumio-1 sudo[13813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hostname volumio-altanok Jun 12 20:36:06 volumio-1 sudo[13813]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:06 volumio-altanok systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 12 20:36:06 volumio-altanok volumio[898]: info: New hostname set Jun 12 20:36:06 volumio-altanok volumio[898]: info: Permissions for /etc/avahi/services/volumio.service Jun 12 20:36:06 volumio-altanok volumio[898]: info: Avahi name changed to volumio-altanok Jun 12 20:36:06 volumio-altanok sudo[13813]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:06 volumio-altanok sudo[13817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ Jun 12 20:36:06 volumio-altanok sudo[13817]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:06 volumio-altanok sudo[13817]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:06 volumio-altanok avahi-daemon[616]: Files changed, reloading. Jun 12 20:36:06 volumio-altanok avahi-daemon[616]: Service group file /services/volumio.service changed, reloading. Jun 12 20:36:06 volumio-altanok sudo[13810]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:06 volumio-altanok volumio[898]: info: Shairport-Sync Started Jun 12 20:36:07 volumio-altanok avahi-daemon[616]: Service "Volumio-altanok" (/services/volumio.service) successfully established. Jun 12 20:36:07 volumio-altanok volumio[898]: info: Discovery: A device disappeared from network Jun 12 20:36:07 volumio-altanok volumio[898]: info: Discovery: Device volumio-1 disappeared from network Jun 12 20:36:07 volumio-altanok volumio[898]: info: Discovery: A device disappeared from network Jun 12 20:36:11 volumio-altanok volumio[898]: info: Discovery: Started advertising with name: Volumio-altanok Jun 12 20:36:11 volumio-altanok volumio[898]: error: Failed to update MyVolumio device: {"message":"Unauthenticated"} Jun 12 20:36:12 volumio-altanok volumio[898]: info: Discovery: adding f493da5d-d91a-4ae5-8b40-5ad5c17f89f8 Jun 12 20:36:12 volumio-altanok volumio[898]: info: Discovery: Found device Volumio-altanok Jun 12 20:36:12 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:12 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:12 volumio-altanok volumio[898]: info: Discovery: this is already registered, f493da5d-d91a-4ae5-8b40-5ad5c17f89f8 Jun 12 20:36:12 volumio-altanok volumio[898]: info: Discovery: Found device Volumio-altanok Jun 12 20:36:12 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:12 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:12 volumio-altanok volumio[898]: verbose: New Socket.io Connection to 192.168.1.51:3000 from 192.168.1.50 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 12 20:36:12 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 12 20:36:12 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:12 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:13 volumio-altanok volumio[898]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jun 12 20:36:13 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jun 12 20:36:13 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jun 12 20:36:13 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 12 20:36:13 volumio-altanok volumio-remote-updater[619]: No test mode Jun 12 20:36:13 volumio-altanok volumio-remote-updater[619]: No alpha test mode Jun 12 20:36:13 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 12 20:36:13 volumio-altanok volumio[898]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES



 

","title":"Update v3.816","updateavailable":true} Jun 12 20:36:13 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 12 20:36:14 volumio-altanok volumio[898]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jun 12 20:36:14 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jun 12 20:36:14 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jun 12 20:36:14 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 12 20:36:14 volumio-altanok volumio-remote-updater[619]: No test mode Jun 12 20:36:14 volumio-altanok volumio-remote-updater[619]: No alpha test mode Jun 12 20:36:14 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 12 20:36:14 volumio-altanok volumio[898]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES



 

","title":"Update v3.816","updateavailable":true} Jun 12 20:36:14 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 12 20:36:16 volumio-altanok sudo[13883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf Jun 12 20:36:16 volumio-altanok sudo[13883]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:16 volumio-altanok sudo[13883]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:16 volumio-altanok volumio[898]: info: smb.conf Permissions set Jun 12 20:36:16 volumio-altanok sudo[13886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL Jun 12 20:36:16 volumio-altanok sudo[13886]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:16 volumio-altanok sudo[13886]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:16 volumio-altanok sudo[13889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service Jun 12 20:36:16 volumio-altanok sudo[13889]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:16 volumio-altanok sudo[13892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 12 20:36:16 volumio-altanok systemd[1]: Stopping Samba NMB Daemon... Jun 12 20:36:16 volumio-altanok sudo[13892]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:16 volumio-altanok nmbd[747]: [2025/06/12 20:36:16.459856, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jun 12 20:36:16 volumio-altanok nmbd[747]: started asyncdns process 13895 Jun 12 20:36:16 volumio-altanok sudo[13892]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:16 volumio-altanok volumio[898]: info: Internal perms successfully set Jun 12 20:36:16 volumio-altanok sudo[13896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 12 20:36:16 volumio-altanok sudo[13896]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:16 volumio-altanok sudo[13896]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:16 volumio-altanok sudo[13899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 12 20:36:16 volumio-altanok sudo[13899]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:16 volumio-altanok systemd[1]: Started UPnP Renderer front-end to MPD. Jun 12 20:36:16 volumio-altanok sudo[13899]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:16 volumio-altanok volumio[898]: info: Upmpdcli Daemon Started Jun 12 20:36:16 volumio-altanok volumio[13901]: writing RSA key Jun 12 20:36:20 volumio-altanok volumio[898]: info: CALLMETHOD: system_controller system savePrivacySettings [object Object] Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , savePrivacySettings Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::Reload Ui Jun 12 20:36:20 volumio-altanok sudo[13933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 12 20:36:20 volumio-altanok sudo[13933]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:20 volumio-altanok sudo[13933]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:20 volumio-altanok sudo[13935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 12 20:36:20 volumio-altanok sudo[13935]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 12 20:36:20 volumio-altanok sudo[13935]: pam_unix(sudo:session): session closed for user root Jun 12 20:36:20 volumio-altanok volumio[898]: verbose: New Socket.io Connection to 192.168.1.51 from 192.168.1.15 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.5 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 7 Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetVisibleSources Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:20 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 12 20:36:20 volumio-altanok volumio[898]: info: Received Get System Info Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 20:36:20 volumio-altanok volumio[898]: info: Discovery: Getting this device information Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:20 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:20 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:20 volumio-altanok volumio[898]: info: Listing playlists Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jun 12 20:36:20 volumio-altanok volumio[898]: info: Received Get System Version Jun 12 20:36:20 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 12 20:36:20 volumio-altanok volumio[898]: 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: 8 Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetVisibleSources Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:21 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 12 20:36:21 volumio-altanok volumio[898]: info: Received Get System Info Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 20:36:21 volumio-altanok volumio[898]: info: Discovery: Getting this device information Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:21 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:21 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:21 volumio-altanok volumio[898]: info: Listing playlists Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 12 20:36:21 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 12 20:36:22 volumio-altanok volumio[898]: info: Received Get System Info Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 20:36:22 volumio-altanok volumio[898]: info: Discovery: Getting this device information Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:22 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 12 20:36:22 volumio-altanok volumio[898]: info: Received Get System Info Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 12 20:36:22 volumio-altanok volumio[898]: info: Discovery: Getting this device information Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::volumioGetState Jun 12 20:36:22 volumio-altanok volumio[898]: info: CorePlayQueue::getTrack 0 Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 12 20:36:22 volumio-altanok volumio[898]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 12 20:36:23 volumio-altanok volumio[898]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 12 20:36:23 volumio-altanok volumio[898]: [t [Error]: {"error":{"code":503,"message":"Visibility check was unavailable. Please retry the request and contact support if the problem persists","status":"UNAVAILABLE"}}] { Jun 12 20:36:23 volumio-altanok volumio[898]: code: 'auth/internal-error', Jun 12 20:36:23 volumio-altanok volumio[898]: a: null Jun 12 20:36:23 volumio-altanok volumio[898]: } Jun 12 20:36:23 volumio-altanok volumio[898]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 12 20:36:23 volumio-altanok sudo[13976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-12 20:35 Jun 12 20:36:23 volumio-altanok sudo[13976]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"