-- Logs begin at Thu 2019-02-14 23:11:58 NZDT, end at Tue 2025-12-16 12:30:24 NZDT. --
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Retrieving Cloud Streaming UI
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Getting Tidal Cloud Configuration
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Getting Qobuz Cloud Configuration
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Asking plugin for UI Config
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Getting Spotify Cloud Configuration
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Asking plugin for UI Config
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Saving Spotify Acccount
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Got Tidal Cloud Configuration
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Got it
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: Got it
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Dec 16 12:29:18 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:22 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:26 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:30 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:34 volumiohcandrewes volumio[1109]: info: Disabling MyMusic plugin upnp_browser
Dec 16 12:29:34 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers
Dec 16 12:29:34 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 12:29:34 volumiohcandrewes volumio[1109]: info: Disabling plugin upnp_browser
Dec 16 12:29:34 volumiohcandrewes volumio[1109]: info: Done.
Dec 16 12:29:34 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:38 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:42 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:46 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:50 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:54 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:29:58 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:30:02 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:30:05 volumiohcandrewes volumio[1109]: info: Disabling MyMusic plugin airplay_emulation
Dec 16 12:30:05 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync
Dec 16 12:30:05 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 16 12:30:05 volumiohcandrewes volumio[1109]: info: Disabling plugin airplay_emulation
Dec 16 12:30:05 volumiohcandrewes volumio[1109]: info: Done.
Dec 16 12:30:05 volumiohcandrewes sudo[18650]: volumio : unable to resolve host volumiohcandrewes
Dec 16 12:30:05 volumiohcandrewes sudo[18650]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Dec 16 12:30:05 volumiohcandrewes sudo[18650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync
Dec 16 12:30:05 volumiohcandrewes sudo[18650]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 12:30:05 volumiohcandrewes systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Dec 16 12:30:05 volumiohcandrewes systemd[1]: shairport-sync.service: Succeeded.
Dec 16 12:30:05 volumiohcandrewes systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Dec 16 12:30:05 volumiohcandrewes sudo[18650]: pam_unix(sudo:session): session closed for user root
Dec 16 12:30:05 volumiohcandrewes volumio[1109]: info: Shairport-Sync Stopped
Dec 16 12:30:06 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:30:10 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:30:11 volumiohcandrewes volumio[1109]: info: Disabling MyMusic plugin upnp
Dec 16 12:30:11 volumiohcandrewes sudo[18670]: volumio : unable to resolve host volumiohcandrewes
Dec 16 12:30:11 volumiohcandrewes sudo[18670]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Dec 16 12:30:11 volumiohcandrewes sudo[18670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Dec 16 12:30:11 volumiohcandrewes sudo[18670]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 16 12:30:11 volumiohcandrewes systemd[1]: Stopping UPnP Renderer front-end to MPD...
Dec 16 12:30:11 volumiohcandrewes volumio[1109]: error: Upnp client error: Error: This socket has been ended by the other party
Dec 16 12:30:14 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:30:18 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:30:22 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info:
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: ---------------------------- MPD announces system playlist update
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: Ignoring MPD Status Update
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info:
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: ---------------------------- MPD announces state update: player
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: ControllerMpd::getState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: error: updateQueue error: null
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: ------------------------------ 4ms
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: sendMpdCommand status took 3 milliseconds
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: verbose: ControllerMpd::parseState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: ControllerMpd::pushState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::servicePushState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreStateMachine::pushState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CorePlayQueue::getTrack 1
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::volumioPushState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CorePlayQueue::getTrack 1
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: verbose: CURRENT POSITION 1
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreStateMachine::syncState stateService stop
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreStateMachine::syncState currentStatus play
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreStateMachine::play index undefined
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreStateMachine::pushState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CorePlayQueue::getTrack 2
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::volumioPushState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CorePlayQueue::getTrack 2
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreStateMachine::startPlaybackTimer
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CorePlayQueue::getTrack 2
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: verbose: ControllerMpd::clearAddPlayTracks NAS/Lossless/Emmylou Harris/Red Dirt Girl/03 Emmylou Harris I Don’t Wanna Talk About It Now.flac
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: verbose: ControllerMpd::sendMpdCommand stop
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: ------------------------------ 12ms
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreStateMachine::pushState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CorePlayQueue::getTrack 2
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::volumioPushState
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: sendMpdCommand stop took 4 milliseconds
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: verbose: ControllerMpd::sendMpdCommand clear
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info:
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: ---------------------------- MPD announces system playlist update
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: Ignoring MPD Status Update
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: sendMpdCommand clear took 3 milliseconds
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: verbose: ControllerMpd::sendMpdCommand add "NAS/Lossless/Emmylou Harris/Red Dirt Girl/03 Emmylou Harris I Don’t Wanna Talk About It Now.flac"
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: error: updateQueue error: null
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info:
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: ---------------------------- MPD announces system playlist update
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: Ignoring MPD Status Update
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: ------------------------------ 2ms
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: sendMpdCommand add "NAS/Lossless/Emmylou Harris/Red Dirt Girl/03 Emmylou Harris I Don’t Wanna Talk About It Now.flac" took 1 milliseconds
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: verbose: ControllerMpd::sendMpdCommand play
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: ------------------------------ 1ms
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: sendMpdCommand play took 1 milliseconds
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: Enabling MyMusic plugin upnp
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: Enabling plugin upnp
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: Loading plugin "upnp"...
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: [1765841424328] Starting Upmpd Daemon
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: Error: listen EADDRINUSE: address already in use :::6599
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: at Server.setupListenHandle [as _listen2] (net.js:1318:16)
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: at listenInCluster (net.js:1366:12)
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: at Server.listen (net.js:1452:7)
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: code: 'EADDRINUSE',
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: errno: -98,
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: syscall: 'listen',
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: address: '::',
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: port: 6599
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: }
Dec 16 12:30:24 volumiohcandrewes volumio[1109]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 12:30:24 volumiohcandrewes sudo[18696]: volumio : unable to resolve host volumiohcandrewes
Dec 16 12:30:24 volumiohcandrewes sudo[18696]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ;
Dec 16 12:30:24 volumiohcandrewes sudo[18696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-16 12:29
Dec 16 12:30:24 volumiohcandrewes sudo[18696]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET"
VOLUMIO_VERSION="3.874"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"