-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-10-25 23:20:33 CEST. --
Oct 25 23:19:42 volumio kernel: usb 1-1.4: new high-speed USB device number 4 using xhci_hcd
Oct 25 23:19:42 volumio kernel: usb 1-1.4: New USB device found, idVendor=2a39, idProduct=3fd3, bcdDevice= 0.01
Oct 25 23:19:42 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Oct 25 23:19:42 volumio kernel: usb 1-1.4: Product: ADI-2 DAC (51110073)
Oct 25 23:19:42 volumio kernel: usb 1-1.4: Manufacturer: RME
Oct 25 23:19:42 volumio kernel: usb 1-1.4: SerialNumber: B9EEF0E1F738BC8
Oct 25 23:19:42 volumio volumio[884]: info: No valid Plugin REST Endpoint
Oct 25 23:19:42 volumio volumio[884]: info:
Oct 25 23:19:42 volumio volumio[884]: ---------------------------- USB Audio Device Attached
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::Close All Modals sent
Oct 25 23:19:42 volumio volumio[884]: info: Preparing to save Alsa Options, stopping services first
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:19:42 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::volumioPause
Oct 25 23:19:42 volumio volumio[884]: info: CoreStateMachine::pause
Oct 25 23:19:42 volumio volumio[884]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"ADI-2 DAC (51110073)","alsacard":"DAC51110073"},"i2s":false}
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 23:19:42 volumio volumio[884]: info: Setting mixer AES Rate for card ADI-2 DAC (51110073)
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 25 23:19:42 volumio volumio[884]: info: Updating Volume Controller Parameters: Device: 5 Name: ADI-2 DAC (51110073) Mixer: AES Rate Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 25 23:19:42 volumio volumio[884]: info: Disabling external Volume Control
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 23:19:42 volumio volumio[884]: info: Preparing to generate the ALSA configuration file
Oct 25 23:19:42 volumio volumio[884]: Unable to parse:
Oct 25 23:19:42 volumio volumio[884]: Simple mixer control 'AES Rate',0
Oct 25 23:19:42 volumio volumio[884]: Capabilities: volume volume-joined
Oct 25 23:19:42 volumio volumio[884]: Playback channels: Mono
Oct 25 23:19:42 volumio volumio[884]: Capture channels: Mono
Oct 25 23:19:42 volumio volumio[884]: Limits: 0 - 200000
Oct 25 23:19:42 volumio volumio[884]: Mono: 0 [0%]
Oct 25 23:19:42 volumio volumio[884]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 23:19:42 volumio volumio[884]: info: Asound.conf file unchanged, so no further update is needed
Oct 25 23:19:42 volumio volumio[884]: info: Output device has changed, restarting MPD
Oct 25 23:19:42 volumio sudo[14888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 25 23:19:42 volumio sudo[14888]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:19:42 volumio volumio[884]: Unable to parse:
Oct 25 23:19:42 volumio volumio[884]: Simple mixer control 'AES Rate',0
Oct 25 23:19:42 volumio volumio[884]: Capabilities: volume volume-joined
Oct 25 23:19:42 volumio volumio[884]: Playback channels: Mono
Oct 25 23:19:42 volumio volumio[884]: Capture channels: Mono
Oct 25 23:19:42 volumio volumio[884]: Limits: 0 - 200000
Oct 25 23:19:42 volumio volumio[884]: Mono: 0 [0%]
Oct 25 23:19:42 volumio volumio[884]: info: VolumeController:: Volume=undefined Mute =false
Oct 25 23:19:42 volumio sudo[14888]: pam_unix(sudo:session): session closed for user root
Oct 25 23:19:42 volumio volumio[884]: info: CoreStateMachine::pushState
Oct 25 23:19:42 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:19:42 volumio volumio[884]: info: CoreCommandRouter::volumioPushState
Oct 25 23:19:42 volumio sudo[14891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 25 23:19:42 volumio sudo[14891]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:19:43 volumio volumio[884]: info: MPD Permissions set
Oct 25 23:19:43 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:19:43 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:19:43 volumio systemd[1]: musicservicesshield.service: Succeeded.
Oct 25 23:19:43 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Oct 25 23:19:43 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Oct 25 23:19:43 volumio systemd[1]: Stopping Music Player Daemon...
Oct 25 23:19:43 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 23:19:43 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:19:43 volumio systemd[1]: mpd.service: Succeeded.
Oct 25 23:19:43 volumio systemd[1]: Stopped Music Player Daemon.
Oct 25 23:19:43 volumio systemd[1]: Starting Music Player Daemon...
Oct 25 23:19:43 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Oct 25 23:19:43 volumio sudo[14898]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 25 23:19:43 volumio sudo[14898]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:19:43 volumio sudo[14898]: pam_unix(sudo:session): session closed for user root
Oct 25 23:19:43 volumio mpd[14900]: Oct 25 23:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 25 23:19:44 volumio systemd[1]: Started Music Player Daemon.
Oct 25 23:19:44 volumio sudo[14891]: pam_unix(sudo:session): session closed for user root
Oct 25 23:19:44 volumio volumio[884]: error: updateQueue error: null
Oct 25 23:19:44 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Oct 25 23:19:44 volumio volumio[14904]: cset: --> shielding system active with
Oct 25 23:19:44 volumio volumio[14904]: cset: "system" cpuset of CPUSPEC(0,3) with 231 tasks running
Oct 25 23:19:44 volumio volumio[14904]: cset: "user" cpuset of CPUSPEC(1-2) with 3 tasks running
Oct 25 23:19:44 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Oct 25 23:19:46 volumio volumio[884]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 25 23:19:46 volumio volumio[884]: info: CoreStateMachine::getcurrentVolume
Oct 25 23:19:46 volumio volumio[884]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 23:19:46 volumio volumio[884]: Unable to parse:
Oct 25 23:19:46 volumio volumio[884]: Simple mixer control 'AES Rate',0
Oct 25 23:19:46 volumio volumio[884]: Capabilities: volume volume-joined
Oct 25 23:19:46 volumio volumio[884]: Playback channels: Mono
Oct 25 23:19:46 volumio volumio[884]: Capture channels: Mono
Oct 25 23:19:46 volumio volumio[884]: Limits: 0 - 200000
Oct 25 23:19:46 volumio volumio[884]: Mono: 0 [0%]
Oct 25 23:19:46 volumio volumio[884]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Oct 25 23:19:46 volumio volumio[884]: Unable to parse:
Oct 25 23:19:46 volumio volumio[884]: Simple mixer control 'AES Rate',0
Oct 25 23:19:46 volumio volumio[884]: Capabilities: volume volume-joined
Oct 25 23:19:46 volumio volumio[884]: Playback channels: Mono
Oct 25 23:19:46 volumio volumio[884]: Capture channels: Mono
Oct 25 23:19:46 volumio volumio[884]: Limits: 0 - 200000
Oct 25 23:19:46 volumio volumio[884]: Mono: 0 [0%]
Oct 25 23:19:46 volumio volumio[884]: info: VolumeController:: Volume=undefined Mute =false
Oct 25 23:19:46 volumio volumio[884]: info: CoreStateMachine::pushState
Oct 25 23:19:46 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:19:46 volumio volumio[884]: info: CoreCommandRouter::volumioPushState
Oct 25 23:19:46 volumio volumio[884]: info: CoreStateMachine::updateTrackBlock
Oct 25 23:19:46 volumio volumio[884]: info: CorePlayQueue::getTrackBlock
Oct 25 23:19:46 volumio volumio[884]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 23:19:46 volumio volumio[884]: Unable to parse:
Oct 25 23:19:46 volumio volumio[884]: Simple mixer control 'AES Rate',0
Oct 25 23:19:46 volumio volumio[884]: Capabilities: volume volume-joined
Oct 25 23:19:46 volumio volumio[884]: Playback channels: Mono
Oct 25 23:19:46 volumio volumio[884]: Capture channels: Mono
Oct 25 23:19:46 volumio volumio[884]: Limits: 0 - 200000
Oct 25 23:19:46 volumio volumio[884]: Mono: 0 [0%]
Oct 25 23:19:46 volumio volumio[884]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Oct 25 23:19:46 volumio volumio[884]: Unable to parse:
Oct 25 23:19:46 volumio volumio[884]: Simple mixer control 'AES Rate',0
Oct 25 23:19:46 volumio volumio[884]: Capabilities: volume volume-joined
Oct 25 23:19:46 volumio volumio[884]: Playback channels: Mono
Oct 25 23:19:46 volumio volumio[884]: Capture channels: Mono
Oct 25 23:19:46 volumio volumio[884]: Limits: 0 - 200000
Oct 25 23:19:46 volumio volumio[884]: Mono: 0 [0%]
Oct 25 23:19:46 volumio volumio[884]: info: VolumeController:: Volume=undefined Mute =false
Oct 25 23:19:46 volumio volumio[884]: info: CoreStateMachine::pushState
Oct 25 23:19:46 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:19:46 volumio volumio[884]: info: CoreCommandRouter::volumioPushState
Oct 25 23:19:59 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 23:19:59 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 23:19:59 volumio volumio[884]: info: Discovery: Getting this device information
Oct 25 23:19:59 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:19:59 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:19:59 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 23:19:59 volumio volumio[884]: verbose: New Socket.io Connection to 192.168.1.135:3000 from 192.168.1.138 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7
Oct 25 23:19:59 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:19:59 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:19:59 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 25 23:19:59 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 25 23:20:01 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:01 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:02 volumio sudo[14959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 25 23:20:02 volumio sudo[14959]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:20:02 volumio sudo[14959]: pam_unix(sudo:session): session closed for user root
Oct 25 23:20:02 volumio sudo[14962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 25 23:20:02 volumio sudo[14962]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:20:02 volumio sudo[14962]: pam_unix(sudo:session): session closed for user root
Oct 25 23:20:02 volumio volumio[884]: verbose: New Socket.io Connection to 192.168.1.135 from 192.168.1.138 UA: Mozilla/5.0 (Linux; Android 15; SM-G991B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Oct 25 23:20:03 volumio sudo[14965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 25 23:20:03 volumio sudo[14965]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:20:03 volumio sudo[14965]: pam_unix(sudo:session): session closed for user root
Oct 25 23:20:03 volumio sudo[14968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 25 23:20:03 volumio sudo[14968]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:20:03 volumio sudo[14968]: pam_unix(sudo:session): session closed for user root
Oct 25 23:20:03 volumio volumio[884]: verbose: New Socket.io Connection to 192.168.1.135 from 192.168.1.138 UA: Mozilla/5.0 (Linux; Android 15; SM-G991B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:03 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 25 23:20:03 volumio volumio[884]: info: Received Get System Info
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 23:20:03 volumio volumio[884]: info: Discovery: Getting this device information
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:03 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:03 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:03 volumio volumio[884]: info: Listing playlists
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 25 23:20:03 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 25 23:20:04 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 25 23:20:04 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 25 23:20:04 volumio volumio[884]: info: Received Get System Info
Oct 25 23:20:04 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 23:20:04 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 23:20:04 volumio volumio[884]: info: Discovery: Getting this device information
Oct 25 23:20:04 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:04 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:04 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 23:20:07 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 25 23:20:07 volumio volumio[884]: info: Received Get System Info
Oct 25 23:20:07 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 23:20:07 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 23:20:07 volumio volumio[884]: info: Discovery: Getting this device information
Oct 25 23:20:07 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:07 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:07 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 23:20:15 volumio volumio[884]: verbose: New Socket.io Connection to 192.168.1.135:3000 from 192.168.1.138 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Oct 25 23:20:15 volumio volumio[884]: verbose: New Socket.io Connection to 192.168.1.135 from 192.168.1.138 UA: Mozilla/5.0 (Linux; Android 15; SM-G991B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Oct 25 23:20:16 volumio volumio[884]: verbose: New Socket.io Connection to 192.168.1.135 from 192.168.1.138 UA: Mozilla/5.0 (Linux; Android 15; SM-G991B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:16 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 25 23:20:16 volumio volumio[884]: info: Received Get System Info
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 23:20:16 volumio volumio[884]: info: Discovery: Getting this device information
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:16 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:16 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:16 volumio volumio[884]: info: Listing playlists
Oct 25 23:20:16 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 25 23:20:18 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 25 23:20:18 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 25 23:20:18 volumio volumio[884]: info: Discovery: Getting this device information
Oct 25 23:20:18 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:18 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:18 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 23:20:19 volumio volumio[884]: info: Retrieving Cloud Streaming UI
Oct 25 23:20:19 volumio volumio[884]: info: Getting Tidal Cloud Configuration
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 23:20:19 volumio volumio[884]: info: Getting Qobuz Cloud Configuration
Oct 25 23:20:19 volumio volumio[884]: info: Asking plugin for UI Config
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 23:20:19 volumio volumio[884]: info: Getting Spotify Cloud Configuration
Oct 25 23:20:19 volumio volumio[884]: info: Asking plugin for UI Config
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 23:20:19 volumio volumio[884]: info: Saving Spotify Acccount
Oct 25 23:20:19 volumio volumio[884]: info: Got Tidal Cloud Configuration
Oct 25 23:20:19 volumio volumio[884]: info: Got it
Oct 25 23:20:19 volumio volumio[884]: info: Got it
Oct 25 23:20:19 volumio volumio[884]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 23:20:19 volumio volumio[884]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 25 23:20:19 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Oct 25 23:20:21 volumio volumio[884]: info: Disabling MyMusic plugin upnp
Oct 25 23:20:21 volumio sudo[15044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Oct 25 23:20:21 volumio sudo[15044]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:20:21 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
Oct 25 23:20:21 volumio volumio[884]: error: Upnp client error: Error: This socket has been ended by the other party
Oct 25 23:20:23 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 25 23:20:25 volumio kernel: usb 1-1.4: USB disconnect, device number 4
Oct 25 23:20:25 volumio volumio[884]: info:
Oct 25 23:20:25 volumio volumio[884]: ---------------------------- USB Audio Device Detached
Oct 25 23:20:25 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Oct 25 23:20:25 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 23:20:25 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Oct 25 23:20:25 volumio volumio[884]: info: No valid Plugin REST Endpoint
Oct 25 23:20:27 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 25 23:20:29 volumio kernel: usb 1-1.4: new high-speed USB device number 5 using xhci_hcd
Oct 25 23:20:29 volumio kernel: usb 1-1.4: New USB device found, idVendor=2a39, idProduct=3fd3, bcdDevice= 0.01
Oct 25 23:20:29 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Oct 25 23:20:29 volumio kernel: usb 1-1.4: Product: ADI-2 DAC (51110073)
Oct 25 23:20:29 volumio kernel: usb 1-1.4: Manufacturer: RME
Oct 25 23:20:29 volumio kernel: usb 1-1.4: SerialNumber: B9EEF0E1F738BC8
Oct 25 23:20:29 volumio volumio[884]: info:
Oct 25 23:20:29 volumio volumio[884]: ---------------------------- USB Audio Device Attached
Oct 25 23:20:29 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Oct 25 23:20:29 volumio volumio[884]: info: CoreCommandRouter::Close All Modals sent
Oct 25 23:20:29 volumio volumio[884]: info: Preparing to save Alsa Options, stopping services first
Oct 25 23:20:29 volumio volumio[884]: info: CoreCommandRouter::volumioGetState
Oct 25 23:20:29 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:29 volumio volumio[884]: info: CoreCommandRouter::volumioPause
Oct 25 23:20:29 volumio volumio[884]: info: CoreStateMachine::pause
Oct 25 23:20:29 volumio volumio[884]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"ADI-2 DAC (51110073)","alsacard":"DAC51110073"},"i2s":false}
Oct 25 23:20:29 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 23:20:29 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 23:20:29 volumio volumio[884]: info: Setting mixer AES Rate for card ADI-2 DAC (51110073)
Oct 25 23:20:29 volumio volumio[884]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 25 23:20:29 volumio volumio[884]: info: Updating Volume Controller Parameters: Device: 5 Name: ADI-2 DAC (51110073) Mixer: AES Rate Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 25 23:20:29 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 25 23:20:29 volumio volumio[884]: info: Disabling external Volume Control
Oct 25 23:20:29 volumio volumio[884]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 23:20:29 volumio volumio[884]: info: Preparing to generate the ALSA configuration file
Oct 25 23:20:29 volumio volumio[884]: Unable to parse:
Oct 25 23:20:29 volumio volumio[884]: Simple mixer control 'AES Rate',0
Oct 25 23:20:29 volumio volumio[884]: Capabilities: volume volume-joined
Oct 25 23:20:29 volumio volumio[884]: Playback channels: Mono
Oct 25 23:20:29 volumio volumio[884]: Capture channels: Mono
Oct 25 23:20:29 volumio volumio[884]: Limits: 0 - 200000
Oct 25 23:20:29 volumio volumio[884]: Mono: 0 [0%]
Oct 25 23:20:29 volumio volumio[884]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Oct 25 23:20:30 volumio volumio[884]: info: No valid Plugin REST Endpoint
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 23:20:30 volumio volumio[884]: info: Asound.conf file unchanged, so no further update is needed
Oct 25 23:20:30 volumio volumio[884]: info: Output device has changed, restarting MPD
Oct 25 23:20:30 volumio volumio[884]: Unable to parse:
Oct 25 23:20:30 volumio volumio[884]: Simple mixer control 'AES Rate',0
Oct 25 23:20:30 volumio volumio[884]: Capabilities: volume volume-joined
Oct 25 23:20:30 volumio volumio[884]: Playback channels: Mono
Oct 25 23:20:30 volumio volumio[884]: Capture channels: Mono
Oct 25 23:20:30 volumio volumio[884]: Limits: 0 - 200000
Oct 25 23:20:30 volumio volumio[884]: Mono: 0 [0%]
Oct 25 23:20:30 volumio volumio[884]: info: VolumeController:: Volume=undefined Mute =false
Oct 25 23:20:30 volumio sudo[15086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 25 23:20:30 volumio volumio[884]: info: CoreStateMachine::pushState
Oct 25 23:20:30 volumio volumio[884]: info: CorePlayQueue::getTrack 0
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::volumioPushState
Oct 25 23:20:30 volumio sudo[15086]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:20:30 volumio sudo[15088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 25 23:20:30 volumio sudo[15088]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:20:30 volumio sudo[15086]: pam_unix(sudo:session): session closed for user root
Oct 25 23:20:30 volumio systemd[1]: musicservicesshield.service: Succeeded.
Oct 25 23:20:30 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set.
Oct 25 23:20:30 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set...
Oct 25 23:20:30 volumio systemd[1]: Stopping Music Player Daemon...
Oct 25 23:20:30 volumio volumio[884]: info: MPD Permissions set
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 23:20:30 volumio systemd[1]: mpd.service: Succeeded.
Oct 25 23:20:30 volumio systemd[1]: Stopped Music Player Daemon.
Oct 25 23:20:30 volumio systemd[1]: Starting Music Player Daemon...
Oct 25 23:20:30 volumio sudo[15095]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Oct 25 23:20:30 volumio sudo[15095]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 23:20:30 volumio sudo[15095]: pam_unix(sudo:session): session closed for user root
Oct 25 23:20:30 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Oct 25 23:20:31 volumio mpd[15098]: Oct 25 23:20 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 25 23:20:31 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 25 23:20:31 volumio volumio[884]: error: MPD error: Error: This socket has been ended by the other party
Oct 25 23:20:31 volumio volumio[884]: error: This socket has been ended by the other party {"code":"EPIPE"}
Oct 25 23:20:31 volumio volumio[884]: error: MPD error: Error: This socket has been ended by the other party
Oct 25 23:20:31 volumio volumio[884]: error: This socket has been ended by the other party {"code":"EPIPE"}
Oct 25 23:20:31 volumio volumio[884]: error: MPD error: Error: This socket has been ended by the other party
Oct 25 23:20:31 volumio volumio[884]: error: This socket has been ended by the other party {"code":"EPIPE"}
Oct 25 23:20:31 volumio systemd[1]: Started Music Player Daemon.
Oct 25 23:20:31 volumio sudo[15088]: pam_unix(sudo:session): session closed for user root
Oct 25 23:20:31 volumio volumio[884]: error: updateQueue error: null
Oct 25 23:20:31 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Oct 25 23:20:32 volumio volumio[15115]: cset: --> shielding system active with
Oct 25 23:20:32 volumio volumio[15115]: cset: "system" cpuset of CPUSPEC(0,3) with 233 tasks running
Oct 25 23:20:32 volumio volumio[15115]: cset: "user" cpuset of CPUSPEC(1-2) with 3 tasks running
Oct 25 23:20:32 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Oct 25 23:20:32 volumio volumio[884]: info: Enabling MyMusic plugin upnp
Oct 25 23:20:32 volumio volumio[884]: info: Enabling plugin upnp
Oct 25 23:20:32 volumio volumio[884]: info: Loading plugin "upnp"...
Oct 25 23:20:32 volumio volumio[884]: info: [1761427232971] Starting Upmpd Daemon
Oct 25 23:20:32 volumio volumio[884]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 25 23:20:32 volumio volumio[884]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 25 23:20:32 volumio volumio[884]: Error: listen EADDRINUSE: address already in use :::6599
Oct 25 23:20:32 volumio volumio[884]: at Server.setupListenHandle [as _listen2] (net.js:1318:16)
Oct 25 23:20:32 volumio volumio[884]: at listenInCluster (net.js:1366:12)
Oct 25 23:20:32 volumio volumio[884]: at Server.listen (net.js:1452:7)
Oct 25 23:20:32 volumio volumio[884]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Oct 25 23:20:32 volumio volumio[884]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Oct 25 23:20:32 volumio volumio[884]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Oct 25 23:20:32 volumio volumio[884]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Oct 25 23:20:32 volumio volumio[884]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
Oct 25 23:20:32 volumio volumio[884]: code: 'EADDRINUSE',
Oct 25 23:20:32 volumio volumio[884]: errno: -98,
Oct 25 23:20:32 volumio volumio[884]: syscall: 'listen',
Oct 25 23:20:32 volumio volumio[884]: address: '::',
Oct 25 23:20:32 volumio volumio[884]: port: 6599
Oct 25 23:20:32 volumio volumio[884]: }
Oct 25 23:20:32 volumio volumio[884]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 25 23:20:33 volumio sudo[15139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-25 23:19
Oct 25 23:20:33 volumio sudo[15139]: 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"