Apr 23 10:41:01 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Apr 23 10:41:01 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 10:41:01 volumio volumio-remote-updater[934]: No test mode
Apr 23 10:41:01 volumio volumio-remote-updater[934]: No alpha test mode
Apr 23 10:41:01 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 23 10:41:01 volumio volumio[1323]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
NEW ADDITIONS
- Update to TIDAL Connect
- Add Install-to-disk option for the new RPi5 HW revisions
","title":"Update v3.799","updateavailable":true}
Apr 23 10:41:01 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 23 10:41:07 volumio sudo[2374]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 10:41:07 volumio sudo[2374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:07 volumio sudo[2376]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 23 10:41:07 volumio sudo[2376]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:07 volumio sudo[2374]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:07 volumio sudo[2376]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:07 volumio volumio[1323]: verbose: New Socket.io Connection to 192.168.0.173 from 192.168.0.247 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Apr 23 10:41:07 volumio volumio[1323]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 10:41:07 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 10:41:25 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Apr 23 10:41:25 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 10:41:25 volumio systemd[1]: systemd-timedated.service: Deactivated successfully.
Apr 23 10:41:25 volumio volumio-remote-updater[934]: No test mode
Apr 23 10:41:25 volumio volumio-remote-updater[934]: No alpha test mode
Apr 23 10:41:25 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 23 10:41:25 volumio volumio[1323]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
NEW ADDITIONS
- Update to TIDAL Connect
- Add Install-to-disk option for the new RPi5 HW revisions
","title":"Update v3.799","updateavailable":true}
Apr 23 10:41:25 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 23 10:41:30 volumio sudo[2411]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 10:41:30 volumio sudo[2411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:30 volumio sudo[2411]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:30 volumio sudo[2413]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 23 10:41:30 volumio sudo[2413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:30 volumio sudo[2413]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:30 volumio volumio[1323]: verbose: New Socket.io Connection to 192.168.0.173 from 192.168.0.247 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/135.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Apr 23 10:41:30 volumio volumio[1323]: info: Received Get System Info
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 23 10:41:30 volumio volumio[1323]: info: Discovery: Getting this device information
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::volumioGetState
Apr 23 10:41:30 volumio volumio[1323]: info: CorePlayQueue::getTrack 0
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 23 10:41:30 volumio volumio-remote-updater[934]: No test mode
Apr 23 10:41:30 volumio volumio-remote-updater[934]: No alpha test mode
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 23 10:41:30 volumio volumio[1323]: info: Retrieving Cloud Streaming UI
Apr 23 10:41:30 volumio volumio[1323]: info: Getting Tidal Cloud Configuration
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 23 10:41:30 volumio volumio[1323]: info: Getting Qobuz Cloud Configuration
Apr 23 10:41:30 volumio volumio[1323]: info: Asking plugin for UI Config
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 23 10:41:30 volumio volumio[1323]: info: Getting Spotify Cloud Configuration
Apr 23 10:41:30 volumio volumio[1323]: info: Asking plugin for UI Config
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 23 10:41:30 volumio volumio[1323]: info: Saving Spotify Acccount
Apr 23 10:41:30 volumio volumio[1323]: info: Got Tidal Cloud Configuration
Apr 23 10:41:30 volumio volumio[1323]: info: Got it
Apr 23 10:41:30 volumio volumio[1323]: info: Got it
Apr 23 10:41:30 volumio volumio[1323]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 23 10:41:30 volumio volumio[1323]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Apr 23 10:41:30 volumio volumio[1323]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
NEW ADDITIONS
- Update to TIDAL Connect
- Add Install-to-disk option for the new RPi5 HW revisions
","title":"Update v3.799","updateavailable":true}
Apr 23 10:41:30 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 23 10:41:31 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Apr 23 10:41:31 volumio volumio[1323]: info: Loading i18n strings for locale en
Apr 23 10:41:31 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Apr 23 10:41:31 volumio volumio[1323]: info: Setting timezone to Europe/London
Apr 23 10:41:31 volumio sudo[2423]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Apr 23 10:41:31 volumio sudo[2423]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:31 volumio sudo[2423]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:31 volumio sudo[2427]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/London /etc/localtime
Apr 23 10:41:31 volumio sudo[2427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:31 volumio sudo[2427]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:31 volumio sudo[2431]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Apr 23 10:41:31 volumio sudo[2431]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:31 volumio sudo[2431]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:31 volumio sudo[2436]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/London
Apr 23 10:41:31 volumio sudo[2436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:31 volumio dbus-daemon[923]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.26' (uid=0 pid=2437 comm="/usr/bin/timedatectl set-timezone Europe/London")
Apr 23 10:41:31 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Apr 23 10:41:31 volumio dbus-daemon[923]: [system] Successfully activated service 'org.freedesktop.timedate1'
Apr 23 10:41:31 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
Apr 23 10:41:31 volumio sudo[2436]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:31 volumio volumio[1323]: Updating browse sources language
Apr 23 10:41:31 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 10:41:31 volumio volumio[1323]: info: Fetching Streaming Services browse cache
Apr 23 10:41:32 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Apr 23 10:41:32 volumio volumio[1323]: info: MyVolumio login type: Token
Apr 23 10:41:33 volumio volumio[1323]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Apr 23 10:41:33 volumio volumio[1323]: info: MyVolumio token set successfully
Apr 23 10:41:33 volumio volumio[1323]: info: MYVOLUMIO: Adding device
Apr 23 10:41:33 volumio volumio[1323]: info: MYVOLUMIO: Evaluating Server
Apr 23 10:41:33 volumio volumio[1323]: info: MyVolumio status changed
Apr 23 10:41:33 volumio volumio[1323]: info: Streaming services startup
Apr 23 10:41:33 volumio volumio[1323]: info: Starting Streaming Daemon
Apr 23 10:41:33 volumio volumio[1323]: info: Removing browser output: myVolumio user plan is not superstar
Apr 23 10:41:33 volumio volumio[1323]: info: Removing audio output:
Apr 23 10:41:33 volumio volumio[1323]: info: Stoppping Tunnel 1
Apr 23 10:41:33 volumio sudo[2457]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 23 10:41:33 volumio sudo[2457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:33 volumio sudo[2459]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Apr 23 10:41:33 volumio sudo[2459]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:33 volumio sudo[2457]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Apr 23 10:41:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Apr 23 10:41:33 volumio volumio[1323]: error: Cannot start Volumio Streaming Daemon
Apr 23 10:41:33 volumio volumio[1323]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 23 10:41:33 volumio volumio[1323]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 23 10:41:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Apr 23 10:41:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Apr 23 10:41:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Apr 23 10:41:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Apr 23 10:41:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Apr 23 10:41:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Apr 23 10:41:33 volumio sudo[2459]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:33 volumio volumio[1323]: info: Remote SSH Stopped
Apr 23 10:41:34 volumio volumio[1323]: info: Setting Geolocation for MyVolumio to eu3
Apr 23 10:41:34 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:34 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:34 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:34 volumio volumio[1323]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Apr 23 10:41:35 volumio volumio[1323]: info: Updating MyVolumio device info
Apr 23 10:41:35 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:35 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:35 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:35 volumio volumio[1323]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Apr 23 10:41:38 volumio volumio[1323]: info: MYVOLUMIO: Adding device
Apr 23 10:41:38 volumio volumio[1323]: info: MYVOLUMIO: Evaluating Server
Apr 23 10:41:38 volumio volumio[1323]: info: Setting Geolocation for MyVolumio to eu3
Apr 23 10:41:38 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:38 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:38 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:39 volumio volumio[1323]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Apr 23 10:41:39 volumio volumio[1323]: info: Updating MyVolumio device info
Apr 23 10:41:39 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:39 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:39 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:40 volumio volumio[1323]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Apr 23 10:41:46 volumio volumio[1323]: verbose: New Socket.io Connection to 192.168.0.173 from 192.168.0.151 UA: Mozilla/5.0 (Linux; Android 12; moto g200 5G Build/S1RXS32.50-13-25; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.35 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Apr 23 10:41:46 volumio volumio[1323]: verbose: New Socket.io Connection to 192.168.0.173 from 192.168.0.151 UA: Mozilla/5.0 (Linux; Android 12; moto g200 5G Build/S1RXS32.50-13-25; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.35 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Apr 23 10:41:49 volumio volumio[1323]: verbose: New Socket.io Connection to 192.168.0.173 from 192.168.0.151 UA: Mozilla/5.0 (Linux; Android 12; moto g200 5G Build/S1RXS32.50-13-25; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/136.0.7103.35 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Apr 23 10:41:49 volumio volumio[1323]: info: CoreCommandRouter::volumioGetState
Apr 23 10:41:49 volumio volumio[1323]: info: CorePlayQueue::getTrack 0
Apr 23 10:41:49 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 23 10:41:49 volumio volumio[1323]: info: Listing playlists
Apr 23 10:41:49 volumio volumio[1323]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 23 10:41:49 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 23 10:41:49 volumio volumio[1323]: info: CoreCommandRouter::volumioGetQueue
Apr 23 10:41:49 volumio volumio[1323]: info: CoreStateMachine::getQueue
Apr 23 10:41:49 volumio volumio[1323]: info: CorePlayQueue::getQueue
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
Apr 23 10:41:59 volumio volumio[1323]: info: System name has changed, restarting Shairport Sync
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:59 volumio volumio[1323]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 10:41:59 volumio volumio[1323]: info: Updating MyVolumio device info
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:59 volumio volumio[1323]: info: Discovery: Restarting Advertising due to device name change
Apr 23 10:41:59 volumio sudo[2525]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices
Apr 23 10:41:59 volumio sudo[2525]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:59 volumio sudo[2525]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:59 volumio systemd[1]: upmpdcli.service: Deactivated successfully.
Apr 23 10:41:59 volumio systemd[1]: upmpdcli.service: Consumed 10.750s CPU time.
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:41:59 volumio volumio[1323]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 23 10:41:59 volumio volumio[1323]: info: Starting Shairport Sync
Apr 23 10:41:59 volumio sudo[2531]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts
Apr 23 10:41:59 volumio sudo[2531]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:59 volumio sudo[2534]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 10:41:59 volumio sudo[2534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:59 volumio sudo[2531]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:59 volumio volumio[1323]: info: Permissions for /etc/hosts set
Apr 23 10:41:59 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Apr 23 10:41:59 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Apr 23 10:41:59 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Apr 23 10:41:59 volumio systemd[1]: shairport-sync.service: Consumed 1.550s CPU time.
Apr 23 10:41:59 volumio volumio[1323]: info: Hostname now is volumio-alpha
Apr 23 10:41:59 volumio sudo[2537]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/hostname volumio-alpha
Apr 23 10:41:59 volumio-alpha systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Apr 23 10:41:59 volumio-alpha sudo[2537]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:59 volumio-alpha volumio[1323]: info: New hostname set
Apr 23 10:41:59 volumio-alpha volumio[1323]: info: Permissions for /etc/avahi/services/volumio.service
Apr 23 10:41:59 volumio-alpha volumio[1323]: info: Avahi name changed to volumio-alpha
Apr 23 10:41:59 volumio-alpha sudo[2537]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:59 volumio-alpha sudo[2540]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/
Apr 23 10:41:59 volumio-alpha sudo[2540]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:41:59 volumio-alpha sudo[2540]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:59 volumio-alpha avahi-daemon[921]: Files changed, reloading.
Apr 23 10:41:59 volumio-alpha sudo[2534]: pam_unix(sudo:session): session closed for user root
Apr 23 10:41:59 volumio-alpha avahi-daemon[921]: Loading service file /services/volumio.service.
Apr 23 10:41:59 volumio-alpha volumio[1323]: info: Shairport-Sync Started
Apr 23 10:41:59 volumio-alpha volumio[1323]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Apr 23 10:41:59 volumio-alpha avahi-daemon[921]: Service "Volumio Alpha" (/services/volumio.service) successfully established.
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Discovery: A device disappeared from network
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Discovery: Device volumio disappeared from network
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Discovery: A device disappeared from network
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Discovery: A device disappeared from network
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Preparing to save Alsa Options, stopping services first
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioGetState
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CorePlayQueue::getTrack 0
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioPause
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreStateMachine::pause
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0","label":"HDMI 0 Out"},"disallowPush":true}
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Found match in Cards Database: setting mixer for card HDMI 0 Out
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Device 0 does not have any Mixer Control Available
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI 0 Out Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Disabling external Volume Control
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreStateMachine::pushState
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CorePlayQueue::getTrack 0
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioPushState
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Preparing to generate the ALSA configuration file
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Apr 23 10:42:00 volumio-alpha sudo[2572]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 23 10:42:00 volumio-alpha sudo[2572]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:00 volumio-alpha sudo[2576]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 23 10:42:00 volumio-alpha sudo[2576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 23 10:42:00 volumio-alpha sudo[2576]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Asound.conf file unchanged, so no further update is needed
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Output device has changed, restarting MPD
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Output device has changed, restarting Shairport Sync
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:42:00 volumio-alpha sudo[2585]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 23 10:42:00 volumio-alpha sudo[2585]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:00 volumio-alpha sudo[2587]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 23 10:42:00 volumio-alpha sudo[2587]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:00 volumio-alpha sudo[2585]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: MPD Permissions set
Apr 23 10:42:00 volumio-alpha volumio[1323]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 23 10:42:00 volumio-alpha volumio[1323]: wlan0 Interface doesn't support scanning : Device or resource busy
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Cannot use regular scanning, forcing with ap-force
Apr 23 10:42:00 volumio-alpha sudo[2596]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 23 10:42:00 volumio-alpha sudo[2596]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:00 volumio-alpha systemd[1]: Stopping mpd.service - Music Player Daemon...
Apr 23 10:42:00 volumio-alpha sudo[2596]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:00 volumio-alpha volumio[1323]: command failed: Device or resource busy (-16)
Apr 23 10:42:00 volumio-alpha volumio[1323]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 23 10:42:00 volumio-alpha volumio[1323]: command failed: Device or resource busy (-16)
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 23 10:42:00 volumio-alpha volumio[1323]: info: Starting Shairport Sync
Apr 23 10:42:00 volumio-alpha sudo[2607]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 23 10:42:00 volumio-alpha sudo[2607]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:00 volumio-alpha systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Apr 23 10:42:00 volumio-alpha systemd[1]: shairport-sync.service: Deactivated successfully.
Apr 23 10:42:00 volumio-alpha systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Apr 23 10:42:00 volumio-alpha systemd[1]: shairport-sync.service: Consumed 1.520s CPU time.
Apr 23 10:42:01 volumio-alpha systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Apr 23 10:42:01 volumio-alpha sudo[2607]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:01 volumio-alpha volumio[1323]: info: Shairport-Sync Started
Apr 23 10:42:01 volumio-alpha systemd[1]: mpd.service: Deactivated successfully.
Apr 23 10:42:01 volumio-alpha systemd[1]: Stopped mpd.service - Music Player Daemon.
Apr 23 10:42:01 volumio-alpha systemd[1]: mpd.service: Consumed 1.030s CPU time.
Apr 23 10:42:01 volumio-alpha systemd[1]: mpd.socket: Deactivated successfully.
Apr 23 10:42:01 volumio-alpha systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Apr 23 10:42:01 volumio-alpha systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Apr 23 10:42:01 volumio-alpha systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Apr 23 10:42:01 volumio-alpha systemd[1]: Starting mpd.service - Music Player Daemon...
Apr 23 10:42:01 volumio-alpha sudo[2625]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 23 10:42:01 volumio-alpha sudo[2625]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 23 10:42:01 volumio-alpha sudo[2625]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:01 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Apr 23 10:42:01 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 23 10:42:01 volumio-alpha systemd[1]: systemd-timedated.service: Deactivated successfully.
Apr 23 10:42:01 volumio-alpha mpd[2627]: Apr 23 10:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 23 10:42:01 volumio-alpha systemd[1]: Started mpd.service - Music Player Daemon.
Apr 23 10:42:01 volumio-alpha sudo[2587]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:01 volumio-alpha volumio[1323]: error: updateQueue error: null
Apr 23 10:42:01 volumio-alpha volumio-remote-updater[934]: No test mode
Apr 23 10:42:01 volumio-alpha volumio-remote-updater[934]: No alpha test mode
Apr 23 10:42:01 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 23 10:42:01 volumio-alpha volumio[1323]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
NEW ADDITIONS
- Update to TIDAL Connect
- Add Install-to-disk option for the new RPi5 HW revisions
","title":"Update v3.799","updateavailable":true}
Apr 23 10:42:01 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: Discovery: Started advertising with name: Volumio Alpha
Apr 23 10:42:04 volumio-alpha sudo[2572]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CoreStateMachine::getcurrentVolume
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioRetrievevolume
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CoreStateMachine::pushState
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CorePlayQueue::getTrack 0
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioPushState
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: Discovery: adding 29aefd39-8722-4da9-91ef-b165380b754a
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: Discovery: Found device Volumio Alpha
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioGetState
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CorePlayQueue::getTrack 0
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: Discovery: this is already registered, 29aefd39-8722-4da9-91ef-b165380b754a
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: Discovery: Found device Volumio Alpha
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioGetState
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CorePlayQueue::getTrack 0
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: Discovery: this is already registered, 29aefd39-8722-4da9-91ef-b165380b754a
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: Discovery: Found device Volumio Alpha
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CoreCommandRouter::volumioGetState
Apr 23 10:42:04 volumio-alpha volumio[1323]: info: CorePlayQueue::getTrack 0
Apr 23 10:42:09 volumio-alpha sudo[2652]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf
Apr 23 10:42:09 volumio-alpha sudo[2652]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:09 volumio-alpha sudo[2654]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL
Apr 23 10:42:09 volumio-alpha sudo[2654]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:09 volumio-alpha sudo[2654]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:09 volumio-alpha volumio[1323]: info: Internal perms successfully set
Apr 23 10:42:09 volumio-alpha sudo[2652]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:09 volumio-alpha volumio[1323]: info: smb.conf Permissions set
Apr 23 10:42:09 volumio-alpha sudo[2658]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service
Apr 23 10:42:09 volumio-alpha sudo[2658]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:09 volumio-alpha nmbd[1239]: [2025/04/23 10:42:09.109248, 0] ../../source3/nmbd/nmbd.c:59(terminate)
Apr 23 10:42:09 volumio-alpha nmbd[1239]: Got SIGTERM: going down...
Apr 23 10:42:09 volumio-alpha sudo[2661]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 10:42:09 volumio-alpha systemd[1]: Stopping nmbd.service - Samba NMB Daemon...
Apr 23 10:42:09 volumio-alpha sudo[2661]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:09 volumio-alpha sudo[2663]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 23 10:42:09 volumio-alpha sudo[2663]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:09 volumio-alpha sudo[2661]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:09 volumio-alpha systemd[1]: nmbd.service: Deactivated successfully.
Apr 23 10:42:09 volumio-alpha systemd[1]: Stopped nmbd.service - Samba NMB Daemon.
Apr 23 10:42:09 volumio-alpha sudo[2663]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:09 volumio-alpha sudo[2666]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 23 10:42:09 volumio-alpha sudo[2666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:09 volumio-alpha systemd[1]: Starting nmbd.service - Samba NMB Daemon...
Apr 23 10:42:09 volumio-alpha systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Apr 23 10:42:09 volumio-alpha sudo[2666]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:09 volumio-alpha volumio[1323]: info: Upmpdcli Daemon Started
Apr 23 10:42:09 volumio-alpha upmpdcli[2686]: writing RSA key
Apr 23 10:42:09 volumio-alpha nmbd[2693]: [2025/04/23 10:42:09.244418, 0] ../../source3/nmbd/nmbd.c:901(main)
Apr 23 10:42:09 volumio-alpha nmbd[2693]: nmbd version 4.17.8-Raspbian started.
Apr 23 10:42:09 volumio-alpha nmbd[2693]: Copyright Andrew Tridgell and the Samba Team 1992-2022
Apr 23 10:42:09 volumio-alpha nmbd[2693]: [2025/04/23 10:42:09.245749, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns)
Apr 23 10:42:09 volumio-alpha nmbd[2693]: started asyncdns process 2694
Apr 23 10:42:09 volumio-alpha systemd[1]: Started nmbd.service - Samba NMB Daemon.
Apr 23 10:42:09 volumio-alpha sudo[2658]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:09 volumio-alpha sudo[2696]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart smbd.service
Apr 23 10:42:09 volumio-alpha sudo[2696]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:09 volumio-alpha systemd[1]: Stopping smbd.service - Samba SMB Daemon...
Apr 23 10:42:09 volumio-alpha systemd[1]: smbd.service: Deactivated successfully.
Apr 23 10:42:09 volumio-alpha systemd[1]: Stopped smbd.service - Samba SMB Daemon.
Apr 23 10:42:09 volumio-alpha systemd[1]: Starting smbd.service - Samba SMB Daemon...
Apr 23 10:42:09 volumio-alpha smbd[2701]: [2025/04/23 10:42:09.356971, 0] ../../source3/smbd/server.c:1741(main)
Apr 23 10:42:09 volumio-alpha smbd[2701]: smbd version 4.17.8-Raspbian started.
Apr 23 10:42:09 volumio-alpha smbd[2701]: Copyright Andrew Tridgell and the Samba Team 1992-2022
Apr 23 10:42:09 volumio-alpha systemd[1]: Started smbd.service - Samba SMB Daemon.
Apr 23 10:42:09 volumio-alpha sudo[2696]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:09 volumio-alpha volumio[1323]: info: SAMBA Restarted
Apr 23 10:42:16 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: wizard , connectWirelessNetwork
Apr 23 10:42:16 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , getWiredInfo
Apr 23 10:42:16 volumio-alpha sudo[2720]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 23 10:42:16 volumio-alpha sudo[2720]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:16 volumio-alpha sudo[2720]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:16 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings
Apr 23 10:42:16 volumio-alpha volumio[1323]: info: Saving new wireless network
Apr 23 10:42:16 volumio-alpha sudo[2723]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf
Apr 23 10:42:16 volumio-alpha sudo[2723]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:16 volumio-alpha sudo[2723]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:16 volumio-alpha volumio[1323]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
Apr 23 10:42:16 volumio-alpha volumio[1323]: info: Discovery: Restarting Advertising due to device name change
Apr 23 10:42:16 volumio-alpha sudo[2726]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service
Apr 23 10:42:16 volumio-alpha sudo[2726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:16 volumio-alpha systemd[1]: Starting wireless.service - Wireless Services...
Apr 23 10:42:16 volumio-alpha wireless.js[2728]: Cleaning previous...
Apr 23 10:42:16 volumio-alpha systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server...
Apr 23 10:42:16 volumio-alpha dnsmasq[2048]: exiting on receipt of SIGTERM
Apr 23 10:42:16 volumio-alpha systemd[1]: dnsmasq.service: Deactivated successfully.
Apr 23 10:42:16 volumio-alpha systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server.
Apr 23 10:42:16 volumio-alpha systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet...
Apr 23 10:42:17 volumio-alpha dhcpcd[971]: wlan0: carrier lost
Apr 23 10:42:17 volumio-alpha systemd[1]: hostapd.service: Deactivated successfully.
Apr 23 10:42:17 volumio-alpha systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet.
Apr 23 10:42:17 volumio-alpha sudo[2755]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0
Apr 23 10:42:17 volumio-alpha sudo[2755]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 23 10:42:17 volumio-alpha avahi-daemon[921]: Withdrawing address record for 192.168.211.1 on wlan0.
Apr 23 10:42:17 volumio-alpha avahi-daemon[921]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1.
Apr 23 10:42:17 volumio-alpha avahi-daemon[921]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.188.140.
Apr 23 10:42:17 volumio-alpha avahi-daemon[921]: Withdrawing address record for 169.254.188.140 on wlan0.
Apr 23 10:42:17 volumio-alpha avahi-daemon[921]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.188.140.
Apr 23 10:42:17 volumio-alpha avahi-daemon[921]: Interface wlan0.IPv4 no longer relevant for mDNS.
Apr 23 10:42:17 volumio-alpha dhcpcd[971]: wlan0: deleting route to 169.254.0.0/16
Apr 23 10:42:17 volumio-alpha volumio[1323]: info: Discovery: A device disappeared from network
Apr 23 10:42:17 volumio-alpha sudo[2755]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:17 volumio-alpha sudo[2772]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down
Apr 23 10:42:17 volumio-alpha sudo[2772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 23 10:42:17 volumio-alpha systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0.
Apr 23 10:42:17 volumio-alpha systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0...
Apr 23 10:42:17 volumio-alpha systemd[1]: welcome.service: Deactivated successfully.
Apr 23 10:42:17 volumio-alpha systemd[1]: Stopped welcome.service - Show a welcome message on console.
Apr 23 10:42:17 volumio-alpha systemd[1]: Stopping welcome.service - Show a welcome message on console...
Apr 23 10:42:17 volumio-alpha systemd[1]: Starting welcome.service - Show a welcome message on console...
Apr 23 10:42:17 volumio-alpha volumio[1323]: info: Discovery: A device disappeared from network
Apr 23 10:42:17 volumio-alpha volumio[1323]: info: Discovery: A device disappeared from network
Apr 23 10:42:17 volumio-alpha welcome[2784]: Resolved ip:[1] 192.168.0.173
Apr 23 10:42:17 volumio-alpha sudo[2772]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:17 volumio-alpha systemd[1]: Finished welcome.service - Show a welcome message on console.
Apr 23 10:42:17 volumio-alpha systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0.
Apr 23 10:42:17 volumio-alpha systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0.
Apr 23 10:42:17 volumio-alpha systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0...
Apr 23 10:42:17 volumio-alpha systemd[1]: welcome.service: Deactivated successfully.
Apr 23 10:42:17 volumio-alpha systemd[1]: Stopped welcome.service - Show a welcome message on console.
Apr 23 10:42:17 volumio-alpha systemd[1]: Stopping welcome.service - Show a welcome message on console...
Apr 23 10:42:17 volumio-alpha systemd[1]: Starting welcome.service - Show a welcome message on console...
Apr 23 10:42:18 volumio-alpha welcome[2805]: Resolved ip:[1] 192.168.0.173
Apr 23 10:42:18 volumio-alpha systemd[1]: Finished welcome.service - Show a welcome message on console.
Apr 23 10:42:18 volumio-alpha systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0.
Apr 23 10:42:18 volumio-alpha wireless.js[2728]: Stopped aP
Apr 23 10:42:18 volumio-alpha sudo[2812]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 23 10:42:18 volumio-alpha sudo[2812]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:18 volumio-alpha kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Apr 23 10:42:18 volumio-alpha sudo[2812]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:18 volumio-alpha sudo[2814]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Apr 23 10:42:18 volumio-alpha sudo[2814]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:18 volumio-alpha sudo[2814]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:18 volumio-alpha sudo[2822]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 23 10:42:18 volumio-alpha sudo[2822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:18 volumio-alpha sudo[2822]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:18 volumio-alpha sudo[2824]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Apr 23 10:42:18 volumio-alpha sudo[2824]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:19 volumio-alpha ntpd[1097]: IO: Deleting interface #5 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=135 secs
Apr 23 10:42:19 volumio-alpha ntpd[1097]: IO: Deleting interface #6 wlan0, 169.254.188.140#123, interface stats: received=0, sent=0, dropped=0, active_time=124 secs
Apr 23 10:42:20 volumio-alpha sudo[2824]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:20 volumio-alpha wireless.js[2728]: SETTING APPROPRIATE REG DOMAIN: DE
Apr 23 10:42:20 volumio-alpha sudo[2830]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Apr 23 10:42:20 volumio-alpha sudo[2830]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:20 volumio-alpha sudo[2830]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:20 volumio-alpha sudo[2832]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE
Apr 23 10:42:20 volumio-alpha sudo[2832]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:20 volumio-alpha sudo[2832]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:20 volumio-alpha wireless.js[2728]: SUCCESSFULLY SET NEW REGDOMAIN: DE
Apr 23 10:42:20 volumio-alpha wireless.js[2728]: Start wireless flow
Apr 23 10:42:20 volumio-alpha wireless.js[2728]: Stopped hotspot (if there)..
Apr 23 10:42:20 volumio-alpha sudo[2837]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0
Apr 23 10:42:20 volumio-alpha sudo[2837]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 23 10:42:20 volumio-alpha sudo[2837]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:20 volumio-alpha sudo[2839]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down
Apr 23 10:42:20 volumio-alpha sudo[2839]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 23 10:42:21 volumio-alpha sudo[2839]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:21 volumio-alpha wireless.js[2728]: DHCP IP
Apr 23 10:42:21 volumio-alpha wireless.js[2728]: Start ap
Apr 23 10:42:21 volumio-alpha wpa_supplicant[2841]: Successfully initialized wpa_supplicant
Apr 23 10:42:21 volumio-alpha sudo[2842]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Apr 23 10:42:21 volumio-alpha sudo[2842]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Apr 23 10:42:21 volumio-alpha dhcpcd[971]: control_free: No such file or directory
Apr 23 10:42:21 volumio-alpha dhcpcd[971]: control command: /sbin/dhcpcd
Apr 23 10:42:21 volumio-alpha sudo[2842]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:21 volumio-alpha kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Apr 23 10:42:21 volumio-alpha dhcpcd[971]: lo: IAID 00:00:00:00
Apr 23 10:42:21 volumio-alpha dhcpcd[971]: lo: adding address fe80::44:78ef:ac26:8fbb
Apr 23 10:42:21 volumio-alpha dhcpcd[971]: ipv6_addaddr1: Permission denied
Apr 23 10:42:21 volumio-alpha dhcpcd[971]: lo: using static address 127.0.0.1/8
Apr 23 10:42:21 volumio-alpha dhcpcd[971]: lo: adding route to 127.0.0.0/8
Apr 23 10:42:21 volumio-alpha systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo.
Apr 23 10:42:21 volumio-alpha systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Apr 23 10:42:21 volumio-alpha systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Apr 23 10:42:21 volumio-alpha systemd[1]: welcome.service: Deactivated successfully.
Apr 23 10:42:21 volumio-alpha systemd[1]: Stopped welcome.service - Show a welcome message on console.
Apr 23 10:42:21 volumio-alpha systemd[1]: Stopping welcome.service - Show a welcome message on console...
Apr 23 10:42:21 volumio-alpha systemd[1]: Starting welcome.service - Show a welcome message on console...
Apr 23 10:42:21 volumio-alpha welcome[2884]: Resolved ip:[1] 192.168.0.173
Apr 23 10:42:21 volumio-alpha systemd[1]: Finished welcome.service - Show a welcome message on console.
Apr 23 10:42:21 volumio-alpha systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Apr 23 10:42:21 volumio-alpha wpa_supplicant[2841]: nl80211: kernel reports: Registration to specific type not supported
Apr 23 10:42:21 volumio-alpha nmbd[2693]: [2025/04/23 10:42:21.266144, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Apr 23 10:42:21 volumio-alpha nmbd[2693]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Apr 23 10:42:21 volumio-alpha nmbd[2693]: [2025/04/23 10:42:21.266219, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Apr 23 10:42:21 volumio-alpha nmbd[2693]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Apr 23 10:42:21 volumio-alpha nmbd[2693]: [2025/04/23 10:42:21.266234, 0] ../../source3/nmbd/nmbd_nameregister.c:344(multihomed_register_one)
Apr 23 10:42:21 volumio-alpha nmbd[2693]: multihomed_register_one: Failed to send packet trying to register name VOLUMIO ALPHA<20> IP 192.168.211.1
Apr 23 10:42:21 volumio-alpha nmbd[2693]: [2025/04/23 10:42:21.266270, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Apr 23 10:42:21 volumio-alpha nmbd[2693]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Apr 23 10:42:21 volumio-alpha nmbd[2693]: [2025/04/23 10:42:21.266285, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Apr 23 10:42:21 volumio-alpha nmbd[2693]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Apr 23 10:42:21 volumio-alpha nmbd[2693]: [2025/04/23 10:42:21.266297, 0] ../../source3/nmbd/nmbd_nameregister.c:344(multihomed_register_one)
Apr 23 10:42:21 volumio-alpha nmbd[2693]: multihomed_register_one: Failed to send packet trying to register name VOLUMIO ALPHA<03> IP 192.168.211.1
Apr 23 10:42:21 volumio-alpha nmbd[2693]: [2025/04/23 10:42:21.266319, 0] ../../source3/libsmb/nmblib.c:923(send_udp)
Apr 23 10:42:21 volumio-alpha nmbd[2693]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable
Apr 23 10:42:21 volumio-alpha nmbd[2693]: [2025/04/23 10:42:21.266331, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet)
Apr 23 10:42:21 volumio-alpha nmbd[2693]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed
Apr 23 10:42:21 volumio-alpha nmbd[2693]: [2025/04/23 10:42:21.266342, 0] ../../source3/nmbd/nmbd_nameregister.c:344(multihomed_register_one)
Apr 23 10:42:21 volumio-alpha nmbd[2693]: multihomed_register_one: Failed to send packet trying to register name VOLUMIO ALPHA<00> IP 192.168.211.1
Apr 23 10:42:21 volumio-alpha volumio[1323]: info: Discovery: Started advertising with name: Volumio Alpha
Apr 23 10:42:22 volumio-alpha wireless.js[2728]: trying...
Apr 23 10:42:22 volumio-alpha sudo[2920]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Apr 23 10:42:22 volumio-alpha sudo[2920]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Apr 23 10:42:22 volumio-alpha sudo[2920]: pam_unix(sudo:session): session closed for user root
Apr 23 10:42:22 volumio-alpha volumio[1323]: compat.c: read() failed: Resource temporarily unavailable
Apr 23 10:42:22 volumio-alpha volumio[1323]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 10:42:22 volumio-alpha volumio[1323]: Error: dns service error: unknown
Apr 23 10:42:22 volumio-alpha volumio[1323]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Apr 23 10:42:22 volumio-alpha volumio[1323]: errorCode: -65537
Apr 23 10:42:22 volumio-alpha volumio[1323]: }
Apr 23 10:42:22 volumio-alpha volumio[1323]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 23 10:42:22 volumio-alpha sudo[2938]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-04-23 10:41'
Apr 23 10:42:22 volumio-alpha sudo[2938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="77459d3da1093d939f1a501571c373c95e4a2652"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="0da3792b433b4daf69b90315de2841f333f7f716"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Apr 22 11:07:15 UTC 2025"
VOLUMIO_VERSION="0.058"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cdc65c6dbdd6f51850072894d2c25614"