Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jul 08 15:21:00 volumiolabrat volumio[1085]: info: Preparing to save Alsa Options, stopping services first Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioStop Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreStateMachine::stop Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreStateMachine::stPlaybackTimer Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreStateMachine::updateTrackBlock Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrackBlock Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreStateMachine::pushState Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioPushState Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreStateMachine::serviceStop Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::serviceStop Jul 08 15:21:00 volumiolabrat volumio[1085]: info: [1751959260970] ControllerWebradio::stop Jul 08 15:21:00 volumiolabrat volumio[1085]: verbose: ControllerMpd::sendMpdCommand stop Jul 08 15:21:00 volumiolabrat volumio[1085]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"label":"HiFiBerry DAC Plus"},"output_device":{"value":1,"label":"HiFiBerry DAC Plus"},"disallowPush":true} Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Jul 08 15:21:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Found match in i2s Card Database: setting mixer Digital for card HiFiBerry DAC Plus Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC Plus Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Disabling external Volume Control Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Preparing to generate the ALSA configuration file Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Retrieving Cloud Streaming UI Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Getting Alsa Cards List without I2S DAC Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Asound.conf file unchanged, so no further update is needed Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Output device has changed, restarting MPD Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Output device has changed, restarting Shairport Sync Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 15:21:01 volumiolabrat sudo[2945]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 08 15:21:01 volumiolabrat sudo[2945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 15:21:01 volumiolabrat sudo[2945]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:01 volumiolabrat sudo[2947]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 08 15:21:01 volumiolabrat sudo[2947]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Getting Tidal Cloud Configuration Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Getting Qobuz Cloud Configuration Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Asking plugin for UI Config Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Getting Spotify Cloud Configuration Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Asking plugin for UI Config Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Saving Spotify Acccount Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Got Tidal Cloud Configuration Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Got it Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Got it Jul 08 15:21:01 volumiolabrat volumio[1085]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 08 15:21:01 volumiolabrat volumio[1085]: info: MPD Permissions set Jul 08 15:21:01 volumiolabrat volumio[1085]: info: VolumeController:: Volume=100 Mute =false Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreStateMachine::pushState Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioPushState Jul 08 15:21:01 volumiolabrat systemd[1]: Stopping mpd.service - Music Player Daemon... Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:01 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:01 volumiolabrat volumio[1085]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Starting Shairport Sync Jul 08 15:21:01 volumiolabrat sudo[2960]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 08 15:21:01 volumiolabrat sudo[2960]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 15:21:01 volumiolabrat systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jul 08 15:21:01 volumiolabrat systemd[1]: shairport-sync.service: Deactivated successfully. Jul 08 15:21:01 volumiolabrat systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 15:21:01 volumiolabrat systemd[1]: shairport-sync.service: Consumed 4.641s CPU time. Jul 08 15:21:01 volumiolabrat systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jul 08 15:21:01 volumiolabrat sudo[2960]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:01 volumiolabrat volumio[1085]: info: Shairport-Sync Started Jul 08 15:21:02 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 08 15:21:02 volumiolabrat volumio[1085]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 08 15:21:02 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 08 15:21:02 volumiolabrat volumio[1085]: info: Received Get System Version Jul 08 15:21:02 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 08 15:21:02 volumiolabrat volumio[1085]: info: Received Get System Info Jul 08 15:21:02 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 08 15:21:02 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 08 15:21:02 volumiolabrat volumio[1085]: info: Discovery: Getting this device information Jul 08 15:21:02 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:02 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:02 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 08 15:21:03 volumiolabrat mpd[1352]: player: played "http://as-hls-ww-live.akamaized.net/pool_23461179/live/ww/bbc_radio_three/bbc_radio_three.isml/bbc_radio_three-audio=320000.norewind.m3u8" Jul 08 15:21:03 volumiolabrat volumio[1085]: info: sendMpdCommand stop took 2552 milliseconds Jul 08 15:21:03 volumiolabrat volumio[1085]: info: Jul 08 15:21:03 volumiolabrat volumio[1085]: ---------------------------- MPD announces state update: player Jul 08 15:21:03 volumiolabrat volumio[1085]: info: ControllerMpd::getState Jul 08 15:21:03 volumiolabrat volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Jul 08 15:21:03 volumiolabrat volumio[1085]: error: MPD error: Error: write EPIPE Jul 08 15:21:03 volumiolabrat volumio[1085]: error: write EPIPE {"code":"EPIPE","errno":-32,"syscall":"write"} Jul 08 15:21:03 volumiolabrat volumio[1085]: info: Jul 08 15:21:03 volumiolabrat volumio[1085]: ---------------------------- MPD announces state update: player Jul 08 15:21:03 volumiolabrat volumio[1085]: info: ControllerMpd::getState Jul 08 15:21:03 volumiolabrat volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Jul 08 15:21:03 volumiolabrat volumio[1085]: error: MPD error: Error: write EPIPE Jul 08 15:21:03 volumiolabrat volumio[1085]: error: write EPIPE {"code":"EPIPE","errno":-32,"syscall":"write"} Jul 08 15:21:03 volumiolabrat volumio[1085]: error: MPD error: Error: read ECONNRESET Jul 08 15:21:04 volumiolabrat systemd[1]: mpd.service: Deactivated successfully. Jul 08 15:21:04 volumiolabrat systemd[1]: Stopped mpd.service - Music Player Daemon. Jul 08 15:21:04 volumiolabrat systemd[1]: mpd.service: Consumed 31.197s CPU time. Jul 08 15:21:04 volumiolabrat systemd[1]: mpd.socket: Deactivated successfully. Jul 08 15:21:04 volumiolabrat systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jul 08 15:21:04 volumiolabrat systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jul 08 15:21:04 volumiolabrat volumio[1085]: error: Upnp client error: Error: read ECONNRESET Jul 08 15:21:04 volumiolabrat systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jul 08 15:21:04 volumiolabrat systemd[1]: Starting mpd.service - Music Player Daemon... Jul 08 15:21:04 volumiolabrat sudo[2979]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 08 15:21:04 volumiolabrat sudo[2979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 15:21:04 volumiolabrat sudo[2980]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jul 08 15:21:04 volumiolabrat sudo[2979]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CoreStateMachine::getcurrentVolume Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioRetrievevolume Jul 08 15:21:05 volumiolabrat volumio[1085]: info: VolumeController:: Volume=100 Mute =false Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CoreStateMachine::pushState Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioPushState Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CoreStateMachine::updateTrackBlock Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrackBlock Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioRetrievevolume Jul 08 15:21:05 volumiolabrat volumio[1085]: info: VolumeController:: Volume=100 Mute =false Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CoreStateMachine::pushState Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:05 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioPushState Jul 08 15:21:06 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Jul 08 15:21:06 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jul 08 15:21:06 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Jul 08 15:21:06 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Jul 08 15:21:06 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jul 08 15:21:08 volumiolabrat mpd[2981]: 2025-07-08T15:21:08 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 08 15:21:09 volumiolabrat systemd[1]: Started mpd.service - Music Player Daemon. Jul 08 15:21:09 volumiolabrat sudo[2947]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:09 volumiolabrat volumio[1085]: error: updateQueue error: null Jul 08 15:21:09 volumiolabrat volumio[1085]: error: updateQueue error: null Jul 08 15:21:09 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Jul 08 15:21:09 volumiolabrat volumio[1085]: info: CoreCommandRouter::Reload Ui Jul 08 15:21:09 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Jul 08 15:21:09 volumiolabrat volumio[1085]: info: Wizard terminated Successfully Jul 08 15:21:09 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumiosetStartupVolume Jul 08 15:21:09 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 08 15:21:11 volumiolabrat sudo[3019]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 08 15:21:11 volumiolabrat sudo[3019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 15:21:11 volumiolabrat sudo[3021]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 08 15:21:11 volumiolabrat sudo[3021]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 15:21:11 volumiolabrat sudo[3019]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:11 volumiolabrat sudo[3021]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:11 volumiolabrat sudo[3027]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 08 15:21:11 volumiolabrat sudo[3027]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 15:21:11 volumiolabrat sudo[3029]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 08 15:21:11 volumiolabrat sudo[3029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 15:21:11 volumiolabrat sudo[3029]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:11 volumiolabrat sudo[3027]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:11 volumiolabrat volumio[1085]: verbose: New Socket.io Connection to 192.168.0.134 from 192.168.0.180 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Engine version: 3 Transport: polling Total Clients: 5 Jul 08 15:21:11 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetVisibleSources Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 08 15:21:12 volumiolabrat volumio[1085]: info: Received Get System Info Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 08 15:21:12 volumiolabrat volumio[1085]: info: Discovery: Getting this device information Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:12 volumiolabrat volumio[1085]: info: Listing playlists Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:12 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:13 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 08 15:21:13 volumiolabrat volumio[1085]: info: Received Get System Info Jul 08 15:21:13 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 08 15:21:13 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 08 15:21:13 volumiolabrat volumio[1085]: info: Discovery: Getting this device information Jul 08 15:21:13 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:13 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:13 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 08 15:21:13 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 08 15:21:13 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 08 15:21:15 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jul 08 15:21:15 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 08 15:21:15 volumiolabrat volumio-remote-updater[595]: Test mode disabled Jul 08 15:21:15 volumiolabrat volumio-remote-updater[595]: Alpha mode disabled Jul 08 15:21:15 volumiolabrat volumio-remote-updater[595]: Alpha legacy test mode disabled Jul 08 15:21:15 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 08 15:21:16 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 08 15:21:16 volumiolabrat volumio[1085]: info: Received Get System Info Jul 08 15:21:16 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 08 15:21:16 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 08 15:21:16 volumiolabrat volumio[1085]: info: Discovery: Getting this device information Jul 08 15:21:16 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:16 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:16 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 08 15:21:16 volumiolabrat kernel: hwmon hwmon1: Voltage normalised Jul 08 15:21:16 volumiolabrat volumio[1085]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 08 15:21:16 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 08 15:21:17 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Jul 08 15:21:20 volumiolabrat kernel: hwmon hwmon1: Undervoltage detected! Jul 08 15:21:21 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 08 15:21:21 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jul 08 15:21:21 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 08 15:21:21 volumiolabrat systemd[1]: systemd-timedated.service: Deactivated successfully. Jul 08 15:21:22 volumiolabrat volumio-remote-updater[595]: Test mode disabled Jul 08 15:21:22 volumiolabrat volumio-remote-updater[595]: Alpha mode disabled Jul 08 15:21:22 volumiolabrat volumio-remote-updater[595]: Alpha legacy test mode disabled Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Retrieving Cloud Streaming UI Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Getting Tidal Cloud Configuration Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Getting Qobuz Cloud Configuration Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Asking plugin for UI Config Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Getting Spotify Cloud Configuration Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Asking plugin for UI Config Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Saving Spotify Acccount Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Got Tidal Cloud Configuration Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Got it Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Got it Jul 08 15:21:22 volumiolabrat volumio[1085]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 08 15:21:22 volumiolabrat volumio[1085]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetBrowseSources Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetBrowseSources Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetBrowseSources Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 08 15:21:22 volumiolabrat volumio[1085]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 08 15:21:22 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 08 15:21:24 volumiolabrat kernel: hwmon hwmon1: Voltage normalised Jul 08 15:21:26 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 15:21:30 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 15:21:30 volumiolabrat kernel: hwmon hwmon1: Undervoltage detected! Jul 08 15:21:30 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 08 15:21:30 volumiolabrat volumio[1085]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 08 15:21:30 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 08 15:21:31 volumiolabrat volumio[1085]: info: Received Get System Version Jul 08 15:21:31 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 08 15:21:31 volumiolabrat volumio[1085]: info: Received Get System Info Jul 08 15:21:31 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 08 15:21:31 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 08 15:21:31 volumiolabrat volumio[1085]: info: Discovery: Getting this device information Jul 08 15:21:31 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:31 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:31 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 08 15:21:34 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 15:21:35 volumiolabrat kernel: hwmon hwmon1: Voltage normalised Jul 08 15:21:35 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Jul 08 15:21:35 volumiolabrat sudo[3123]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Squid Jul 08 15:21:35 volumiolabrat sudo[3123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 15:21:35 volumiolabrat systemd[1]: mnt-NAS-Squid.mount: Deactivated successfully. Jul 08 15:21:36 volumiolabrat sudo[3123]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:36 volumiolabrat volumio[1085]: info: Share Squid successfully unmounted Jul 08 15:21:36 volumiolabrat sudo[3130]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.0.104:/volume1/Volumio /mnt/NAS/Squid Jul 08 15:21:36 volumiolabrat sudo[3130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jul 08 15:21:36 volumiolabrat sudo[3130]: pam_unix(sudo:session): session closed for user root Jul 08 15:21:36 volumiolabrat nfsrahead[3136]: setting /mnt/NAS/Squid readahead to 128 Jul 08 15:21:36 volumiolabrat volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Jul 08 15:21:36 volumiolabrat volumio[1085]: info: Jul 08 15:21:36 volumiolabrat volumio[1085]: ---------------------------- MPD announces state update: update Jul 08 15:21:36 volumiolabrat volumio[1085]: info: ControllerMpd::getState Jul 08 15:21:36 volumiolabrat volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Jul 08 15:21:36 volumiolabrat volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Jul 08 15:21:36 volumiolabrat volumio[1085]: info: Jul 08 15:21:36 volumiolabrat volumio[1085]: ---------------------------- MPD announces state update: update Jul 08 15:21:36 volumiolabrat volumio[1085]: info: ControllerMpd::getState Jul 08 15:21:36 volumiolabrat volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Jul 08 15:21:36 volumiolabrat volumio[1085]: info: sendMpdCommand status took 9 milliseconds Jul 08 15:21:36 volumiolabrat volumio[1085]: info: sendMpdCommand status took 7 milliseconds Jul 08 15:21:36 volumiolabrat volumio[1085]: verbose: ControllerMpd::parseState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: Command Router : Notfying DB Updatetrue Jul 08 15:21:36 volumiolabrat volumio[1085]: verbose: ControllerMpd::parseState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: ControllerMpd::pushState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CoreCommandRouter::servicePushState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CoreStateMachine::pushState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioPushState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:36 volumiolabrat volumio[1085]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 08 15:21:36 volumiolabrat volumio[1085]: info: ------------------------------ 167ms Jul 08 15:21:36 volumiolabrat volumio[1085]: info: sendMpdCommand status took 164 milliseconds Jul 08 15:21:36 volumiolabrat volumio[1085]: info: sendMpdCommand status took 162 milliseconds Jul 08 15:21:36 volumiolabrat volumio[1085]: verbose: ControllerMpd::parseState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: Command Router : Notfying DB Updatetrue Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CoreCommandRouter::Close All Modals sent Jul 08 15:21:36 volumiolabrat volumio[1085]: verbose: ControllerMpd::parseState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: ControllerMpd::pushState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CoreCommandRouter::servicePushState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CoreStateMachine::pushState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioPushState Jul 08 15:21:36 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:36 volumiolabrat volumio[1085]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 08 15:21:36 volumiolabrat volumio[1085]: info: ------------------------------ 242ms Jul 08 15:21:36 volumiolabrat volumio[1085]: info: [1751959296696] Database update started Jul 08 15:21:37 volumiolabrat kernel: hwmon hwmon1: Undervoltage detected! Jul 08 15:21:37 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 08 15:21:38 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 08 15:21:43 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetState Jul 08 15:21:43 volumiolabrat volumio[1085]: info: CorePlayQueue::getTrack 0 Jul 08 15:21:47 volumiolabrat kernel: hwmon hwmon1: Voltage normalised Jul 08 15:21:47 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioGetQueue Jul 08 15:21:47 volumiolabrat volumio[1085]: info: CoreStateMachine::getQueue Jul 08 15:21:47 volumiolabrat volumio[1085]: info: CorePlayQueue::getQueue Jul 08 15:21:49 volumiolabrat kernel: hwmon hwmon1: Undervoltage detected! Jul 08 15:21:53 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 08 15:21:53 volumiolabrat volumio[1085]: info: Preload queue cleared Jul 08 15:21:55 volumiolabrat kernel: hwmon hwmon1: Voltage normalised Jul 08 15:21:57 volumiolabrat kernel: hwmon hwmon1: Undervoltage detected! Jul 08 15:21:58 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 08 15:21:58 volumiolabrat volumio[1085]: info: CURURI: music-library Jul 08 15:21:58 volumiolabrat volumio[1085]: info: Preload queue cleared Jul 08 15:21:59 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 08 15:21:59 volumiolabrat volumio[1085]: info: CURURI: music-library/NAS Jul 08 15:22:00 volumiolabrat volumio[1085]: info: Preload queue cleared Jul 08 15:22:00 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 08 15:22:00 volumiolabrat volumio[1085]: info: CURURI: music-library/NAS/Squid Jul 08 15:22:00 volumiolabrat volumio[1085]: info: Preload queue cleared Jul 08 15:22:01 volumiolabrat systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jul 08 15:22:01 volumiolabrat dbus-daemon[583]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.39' (uid=0 pid=3255 comm="timedatectl show --property=NTPSynchronized --valu") Jul 08 15:22:01 volumiolabrat systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jul 08 15:22:02 volumiolabrat dbus-daemon[583]: [system] Successfully activated service 'org.freedesktop.timedate1' Jul 08 15:22:02 volumiolabrat systemd[1]: Started systemd-timedated.service - Time & Date Service. Jul 08 15:22:02 volumiolabrat setdatetime-helper.sh[3254]: Time is not synchronized. Attempting to sync... Jul 08 15:22:02 volumiolabrat sudo[3265]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Tue, 08 Jul 2025 07:22:03 GMT#015' Jul 08 15:22:02 volumiolabrat sudo[3265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jul 08 15:22:03 volumiolabrat setdatetime-helper.sh[3266]: Tue Jul 8 15:22:03 AWST 2025 Jul 08 15:22:03 volumiolabrat sudo[3265]: pam_unix(sudo:session): session closed for user root Jul 08 15:22:03 volumiolabrat setdatetime-helper.sh[3254]: Time synchronized successfully. Jul 08 15:22:03 volumiolabrat systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jul 08 15:22:03 volumiolabrat systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jul 08 15:22:03 volumiolabrat volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 08 15:22:03 volumiolabrat volumio[1085]: info: CURURI: music-library/NAS/Squid/Rock Jul 08 15:22:03 volumiolabrat volumio[1085]: info: Preload queue cleared Jul 08 15:22:03 volumiolabrat ntpd[763]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Jul 08 15:22:04 volumiolabrat ntpd[763]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Jul 08 15:22:04 volumiolabrat ntpd[763]: DNS: Pool skipping: 103.126.53.123 Jul 08 15:22:04 volumiolabrat ntpd[763]: DNS: Pool taking: 27.124.125.252 Jul 08 15:22:04 volumiolabrat ntpd[763]: DNS: Pool taking: 159.196.3.239 Jul 08 15:22:04 volumiolabrat ntpd[763]: DNS: Pool taking: 103.76.40.123 Jul 08 15:22:04 volumiolabrat ntpd[763]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Jul 08 15:22:06 volumiolabrat volumio[1085]: info: Preload queue cleared Jul 08 15:22:06 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 08 15:22:06 volumiolabrat volumio[1085]: info: CoreStateMachine::ClearQueue Jul 08 15:22:06 volumiolabrat volumio[1085]: info: CoreStateMachine::stop Jul 08 15:22:06 volumiolabrat volumio[1085]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 08 15:22:06 volumiolabrat volumio[1085]: info: CorePlayQueue::clearPlayQueue Jul 08 15:22:06 volumiolabrat volumio[1085]: info: CorePlayQueue::saveQueue Jul 08 15:22:06 volumiolabrat volumio[1085]: info: CoreCommandRouter::volumioPushQueue Jul 08 15:22:06 volumiolabrat volumio[1085]: info: CoreStateMachine::addQueueItems Jul 08 15:22:06 volumiolabrat volumio[1085]: info: CorePlayQueue::addQueueItems Jul 08 15:22:06 volumiolabrat volumio[1085]: info: Preload queue cleared Jul 08 15:22:06 volumiolabrat volumio[1085]: info: Adding Item to queue: music-library/NAS/Squid/Rock/Amy Winehouse Jul 08 15:22:06 volumiolabrat volumio[1085]: info: Exploding uri music-library/NAS/Squid/Rock/Amy Winehouse in service mpd Jul 08 15:22:07 volumiolabrat volumio[1085]: info: ALBUMART /albumart?cacheid=819&web=Amy%20Winehouse/Frank/extralarge&path=%2Fmnt%2FNAS%2FSquid%2FRock%2FAmy%20Winehouse%2F2003%20-%20Frank%20(The%20Deluxe%20Edition%202008)%2FCD1%2FAmy%20Winehouse%20-%20Frank.cue&metadata=false Jul 08 15:22:07 volumiolabrat volumio[1085]: info: URI /mnt/NAS/Squid/Rock/Amy Winehouse/2003 - Frank (The Deluxe Edition 2008)/CD1/Amy Winehouse - Frank.cue Jul 08 15:22:07 volumiolabrat volumio[1085]: info: ALBUMART /albumart?cacheid=819&web=Amy%20Winehouse/Frank/extralarge&path=%2Fmnt%2FNAS%2FSquid%2FRock%2FAmy%20Winehouse%2F2003%20-%20Frank%20(The%20Deluxe%20Edition%202008)%2FCD1%2FAmy%20Winehouse%20-%20Frank.cue&metadata=false Jul 08 15:22:07 volumiolabrat volumio[1085]: info: URI /mnt/NAS/Squid/Rock/Amy Winehouse/2003 - Frank (The Deluxe Edition 2008)/CD1/Amy Winehouse - Frank.cue Jul 08 15:22:07 volumiolabrat volumio[1085]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 15:22:07 volumiolabrat volumio[1085]: Error: Unable to resolve or reject the same promise twice Jul 08 15:22:07 volumiolabrat volumio[1085]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 08 15:22:07 volumiolabrat volumio[1085]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Jul 08 15:22:07 volumiolabrat volumio[1085]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jul 08 15:22:07 volumiolabrat volumio[1085]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jul 08 15:22:07 volumiolabrat volumio[1085]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jul 08 15:22:07 volumiolabrat volumio[1085]: at Socket.emit (node:events:514:28) Jul 08 15:22:07 volumiolabrat volumio[1085]: at addChunk (node:internal/streams/readable:343:12) Jul 08 15:22:07 volumiolabrat volumio[1085]: at readableAddChunk (node:internal/streams/readable:312:11) Jul 08 15:22:07 volumiolabrat volumio[1085]: at Readable.push (node:internal/streams/readable:253:10) Jul 08 15:22:07 volumiolabrat volumio[1085]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jul 08 15:22:07 volumiolabrat volumio[1085]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 08 15:22:09 volumiolabrat sudo[3302]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-07-08 15:21' Jul 08 15:22:09 volumiolabrat sudo[3302]: 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="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"