-- Logs begin at Fri 2025-05-23 18:39:13 CEST, end at Fri 2025-05-23 22:20:58 CEST. --
May 23 22:19:21 volumio go-librespot[1565]: time="2025-05-23T22:19:21+02:00" level=trace msg="received accesspoint ping"
May 23 22:19:21 volumio go-librespot[1565]: time="2025-05-23T22:19:21+02:00" level=trace msg="received accesspoint pong ack"
May 23 22:19:21 volumio go-librespot[1565]: time="2025-05-23T22:19:21+02:00" level=trace msg="sent dealer ping"
May 23 22:19:21 volumio go-librespot[1565]: time="2025-05-23T22:19:21+02:00" level=trace msg="received dealer pong"
May 23 22:19:51 volumio go-librespot[1565]: time="2025-05-23T22:19:51+02:00" level=trace msg="sent dealer ping"
May 23 22:19:51 volumio go-librespot[1565]: time="2025-05-23T22:19:51+02:00" level=trace msg="received dealer pong"
May 23 22:20:21 volumio go-librespot[1565]: time="2025-05-23T22:20:21+02:00" level=trace msg="sent dealer ping"
May 23 22:20:21 volumio go-librespot[1565]: time="2025-05-23T22:20:21+02:00" level=trace msg="received dealer pong"
May 23 22:20:28 volumio sudo[27863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 23 22:20:28 volumio sudo[27863]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 23 22:20:28 volumio sudo[27863]: pam_unix(sudo:session): session closed for user root
May 23 22:20:28 volumio sudo[27866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 23 22:20:28 volumio sudo[27866]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 23 22:20:28 volumio sudo[27866]: pam_unix(sudo:session): session closed for user root
May 23 22:20:28 volumio volumio[996]: verbose: New Socket.io Connection to 192.168.1.16 from 192.168.1.11 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::volumioGetVisibleSources
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::volumioGetState
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 23 22:20:28 volumio volumio[996]: info: Received Get System Info
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 23 22:20:28 volumio volumio[996]: info: Discovery: Getting this device information
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::volumioGetState
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::volumioGetState
May 23 22:20:28 volumio volumio[996]: info: Listing playlists
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 23 22:20:28 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
May 23 22:20:29 volumio volumio[996]: info: CoreCommandRouter::volumioGetState
May 23 22:20:29 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 23 22:20:30 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 23 22:20:30 volumio volumio[996]: info: Received Get System Info
May 23 22:20:30 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 23 22:20:30 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 23 22:20:30 volumio volumio[996]: info: Discovery: Getting this device information
May 23 22:20:30 volumio volumio[996]: info: CoreCommandRouter::volumioGetState
May 23 22:20:30 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 23 22:20:31 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 23 22:20:31 volumio volumio[996]: info: Received Get System Info
May 23 22:20:31 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 23 22:20:31 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 23 22:20:31 volumio volumio[996]: info: Discovery: Getting this device information
May 23 22:20:31 volumio volumio[996]: info: CoreCommandRouter::volumioGetState
May 23 22:20:31 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
May 23 22:20:33 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 23 22:20:38 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
May 23 22:20:43 volumio volumio[996]: info:
May 23 22:20:43 volumio volumio[996]: ---------------------------- MPD announces state update: player
May 23 22:20:43 volumio volumio[996]: info: ControllerMpd::getState
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status
May 23 22:20:43 volumio volumio[996]: info:
May 23 22:20:43 volumio volumio[996]: ---------------------------- MPD announces state update: player
May 23 22:20:43 volumio volumio[996]: info: ControllerMpd::getState
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status
May 23 22:20:43 volumio volumio[996]: info:
May 23 22:20:43 volumio volumio[996]: ---------------------------- MPD announces state update: player
May 23 22:20:43 volumio volumio[996]: info: ControllerMpd::getState
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status
May 23 22:20:43 volumio volumio[996]: info: sendMpdCommand status took 0 milliseconds
May 23 22:20:43 volumio volumio[996]: info: sendMpdCommand status took 0 milliseconds
May 23 22:20:43 volumio volumio[996]: info: sendMpdCommand status took 1 milliseconds
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::parseState
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::parseState
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::parseState
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 23 22:20:43 volumio volumio[996]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 23 22:20:43 volumio volumio[996]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 23 22:20:43 volumio volumio[996]: info: sendMpdCommand playlistinfo took 0 milliseconds
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::parseTrackInfo
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::parseTrackInfo
May 23 22:20:43 volumio volumio[996]: verbose: ControllerMpd::parseTrackInfo
May 23 22:20:43 volumio volumio[996]: info: ControllerMpd::pushState
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::servicePushState
May 23 22:20:43 volumio volumio[996]: verbose: In UPNP mode
May 23 22:20:43 volumio volumio[996]: verbose: STATE SERVICE {"status":"play","position":44,"seek":113,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"463 Kbps","isStreaming":false,"title":"Berceuse","artist":"Norbert Kraft","album":"Granados: Spanish Dances / Escenas Poeticas","uri":"https://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEiczNzQ3YzlmOGMxYmI4ZTRiZjkyODk2OGRkOWUyMDNjMV82MS5tcDQ/0.flac?token=1748034992~MjFkMDdjMzZlNWY0ODEzNTQwZDRkYjhjOWUxNzBhYjJiNDkyNTc3Nw==","trackType":"tidal"}
May 23 22:20:43 volumio volumio[996]: verbose: CURRENT POSITION 0
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::syncState stateService play
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus play
May 23 22:20:43 volumio volumio[996]: info: Received an update from plugin. extracting info from payload
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::pushState
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioPushState
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::pushState
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioPushState
May 23 22:20:43 volumio volumio[996]: info: ControllerMpd::pushState
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::servicePushState
May 23 22:20:43 volumio volumio[996]: verbose: In UPNP mode
May 23 22:20:43 volumio volumio[996]: verbose: STATE SERVICE {"status":"play","position":44,"seek":113,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"463 Kbps","isStreaming":false,"title":"Berceuse","artist":"Norbert Kraft","album":"Granados: Spanish Dances / Escenas Poeticas","uri":"https://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEiczNzQ3YzlmOGMxYmI4ZTRiZjkyODk2OGRkOWUyMDNjMV82MS5tcDQ/0.flac?token=1748034992~MjFkMDdjMzZlNWY0ODEzNTQwZDRkYjhjOWUxNzBhYjJiNDkyNTc3Nw==","trackType":"tidal"}
May 23 22:20:43 volumio volumio[996]: verbose: CURRENT POSITION 0
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::syncState stateService play
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus play
May 23 22:20:43 volumio volumio[996]: info: Received an update from plugin. extracting info from payload
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::pushState
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioPushState
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::pushState
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioPushState
May 23 22:20:43 volumio volumio[996]: info: ControllerMpd::pushState
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::servicePushState
May 23 22:20:43 volumio volumio[996]: verbose: In UPNP mode
May 23 22:20:43 volumio volumio[996]: verbose: STATE SERVICE {"status":"play","position":44,"seek":113,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"463 Kbps","isStreaming":false,"title":"Berceuse","artist":"Norbert Kraft","album":"Granados: Spanish Dances / Escenas Poeticas","uri":"https://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEiczNzQ3YzlmOGMxYmI4ZTRiZjkyODk2OGRkOWUyMDNjMV82MS5tcDQ/0.flac?token=1748034992~MjFkMDdjMzZlNWY0ODEzNTQwZDRkYjhjOWUxNzBhYjJiNDkyNTc3Nw==","trackType":"tidal"}
May 23 22:20:43 volumio volumio[996]: verbose: CURRENT POSITION 0
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::syncState stateService play
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus play
May 23 22:20:43 volumio volumio[996]: info: Received an update from plugin. extracting info from payload
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::pushState
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioPushState
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::pushState
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioPushState
May 23 22:20:43 volumio volumio[996]: info: ------------------------------ 6ms
May 23 22:20:43 volumio volumio[996]: info: ------------------------------ 5ms
May 23 22:20:43 volumio volumio[996]: info: ------------------------------ 5ms
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioGetQueue
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::getQueue
May 23 22:20:43 volumio volumio[996]: info: CorePlayQueue::getQueue
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioGetQueue
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::getQueue
May 23 22:20:43 volumio volumio[996]: info: CorePlayQueue::getQueue
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioGetQueue
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::getQueue
May 23 22:20:43 volumio volumio[996]: info: CorePlayQueue::getQueue
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioGetQueue
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::getQueue
May 23 22:20:43 volumio volumio[996]: info: CorePlayQueue::getQueue
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioGetQueue
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::getQueue
May 23 22:20:43 volumio volumio[996]: info: CorePlayQueue::getQueue
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::volumioGetQueue
May 23 22:20:43 volumio volumio[996]: info: CoreStateMachine::getQueue
May 23 22:20:43 volumio volumio[996]: info: CorePlayQueue::getQueue
May 23 22:20:43 volumio volumio[996]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 23 22:20:43 volumio volumio[996]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 23 22:20:43 volumio volumio[996]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 23 22:20:43 volumio volumio[996]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 23 22:20:43 volumio volumio[996]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 23 22:20:43 volumio volumio[996]: SPOTIFY: RECEIVED VOLUMIO VOLUME 90
May 23 22:20:43 volumio volumio[996]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object]
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions
May 23 22:20:43 volumio sudo[27926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 23 22:20:43 volumio sudo[27926]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 23 22:20:43 volumio sudo[27926]: pam_unix(sudo:session): session closed for user root
May 23 22:20:43 volumio volumio[996]: info: MPD Permissions set
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 23 22:20:43 volumio sudo[27930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 23 22:20:43 volumio sudo[27930]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 23 22:20:43 volumio systemd[1]: Stopping Music Player Daemon...
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 23 22:20:43 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 23 22:20:43 volumio systemd[1]: mpd.service: Succeeded.
May 23 22:20:43 volumio systemd[1]: Stopped Music Player Daemon.
May 23 22:20:43 volumio systemd[1]: Starting Music Player Daemon...
May 23 22:20:43 volumio sudo[27938]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 23 22:20:43 volumio sudo[27938]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 23 22:20:43 volumio sudo[27938]: pam_unix(sudo:session): session closed for user root
May 23 22:20:43 volumio mpd[27940]: May 23 22:20 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 23 22:20:43 volumio systemd[1]: Started Music Player Daemon.
May 23 22:20:43 volumio sudo[27930]: pam_unix(sudo:session): session closed for user root
May 23 22:20:43 volumio volumio[996]: error: updateQueue error: null
May 23 22:20:43 volumio volumio[996]: error: Upnp client error: Error: This socket has been ended by the other party
May 23 22:20:44 volumio volumio[996]: error: Upnp client error: Error: This socket has been ended by the other party
May 23 22:20:46 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 23 22:20:46 volumio volumio[996]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 23 22:20:46 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 23 22:20:46 volumio volumio[996]: info: Received Get System Version
May 23 22:20:46 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 23 22:20:46 volumio volumio[996]: info: Received Get System Info
May 23 22:20:46 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 23 22:20:46 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 23 22:20:46 volumio volumio[996]: info: Discovery: Getting this device information
May 23 22:20:46 volumio volumio[996]: info: CoreCommandRouter::volumioGetState
May 23 22:20:46 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 23 22:20:49 volumio volumio[996]: info: CoreCommandRouter::volumioGetState
May 23 22:20:51 volumio go-librespot[1565]: time="2025-05-23T22:20:51+02:00" level=trace msg="sent dealer ping"
May 23 22:20:51 volumio go-librespot[1565]: time="2025-05-23T22:20:51+02:00" level=trace msg="received dealer pong"
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin
May 23 22:20:54 volumio volumio[996]: info: Retrieving Cloud Streaming UI
May 23 22:20:54 volumio volumio[996]: info: Getting Tidal Cloud Configuration
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin
May 23 22:20:54 volumio volumio[996]: info: Getting Qobuz Cloud Configuration
May 23 22:20:54 volumio volumio[996]: info: Asking plugin for UI Config
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin
May 23 22:20:54 volumio volumio[996]: info: Getting Spotify Cloud Configuration
May 23 22:20:54 volumio volumio[996]: info: Asking plugin for UI Config
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin
May 23 22:20:54 volumio volumio[996]: info: Saving Spotify Acccount
May 23 22:20:54 volumio volumio[996]: info: Got Tidal Cloud Configuration
May 23 22:20:54 volumio volumio[996]: info: Got it
May 23 22:20:54 volumio volumio[996]: info: Got it
May 23 22:20:54 volumio volumio[996]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin
May 23 22:20:54 volumio volumio[996]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::volumioGetBrowseSources
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::volumioGetBrowseSources
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::volumioGetBrowseSources
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 23 22:20:54 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 23 22:20:58 volumio volumio[996]: info: Disabling MyMusic plugin upnp
May 23 22:20:58 volumio sudo[28004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
May 23 22:20:58 volumio sudo[28004]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 23 22:20:58 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
May 23 22:20:58 volumio volumio[996]: error: Upnp client error: Error: This socket has been ended by the other party
May 23 22:20:58 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 23 22:20:58 volumio volumio[996]: info: Enabling MyMusic plugin upnp
May 23 22:20:58 volumio volumio[996]: info: Enabling plugin upnp
May 23 22:20:58 volumio volumio[996]: info: Loading plugin "upnp"...
May 23 22:20:58 volumio volumio[996]: info: [1748031658799] Starting Upmpd Daemon
May 23 22:20:58 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 23 22:20:58 volumio volumio[996]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 23 22:20:58 volumio volumio[996]: Error: listen EADDRINUSE: address already in use :::6599
May 23 22:20:58 volumio volumio[996]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
May 23 22:20:58 volumio volumio[996]: at listenInCluster (net.js:1379:12)
May 23 22:20:58 volumio volumio[996]: at Server.listen (net.js:1465:7)
May 23 22:20:58 volumio volumio[996]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
May 23 22:20:58 volumio volumio[996]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
May 23 22:20:58 volumio volumio[996]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
May 23 22:20:58 volumio volumio[996]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
May 23 22:20:58 volumio volumio[996]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
May 23 22:20:58 volumio volumio[996]: code: 'EADDRINUSE',
May 23 22:20:58 volumio volumio[996]: errno: -98,
May 23 22:20:58 volumio volumio[996]: syscall: 'listen',
May 23 22:20:58 volumio volumio[996]: address: '::',
May 23 22:20:58 volumio volumio[996]: port: 6599
May 23 22:20:58 volumio volumio[996]: }
May 23 22:20:58 volumio volumio[996]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 23 22:20:58 volumio sudo[28015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-23 22:19
May 23 22:20:58 volumio sudo[28015]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"