-- Logs begin at Thu 2019-02-14 05:11:59 EST, end at Fri 2026-02-06 21:55:00 EST. --
Feb 06 21:54:01 volumio sudo[22683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 06 21:54:01 volumio sudo[22683]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 06 21:54:01 volumio sudo[22683]: pam_unix(sudo:session): session closed for user root
Feb 06 21:54:01 volumio sudo[22686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 06 21:54:01 volumio sudo[22686]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 06 21:54:01 volumio sudo[22686]: pam_unix(sudo:session): session closed for user root
Feb 06 21:54:01 volumio volumio[923]: verbose: New Socket.io Connection to 192.168.0.171 from 192.168.0.161 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 06 21:54:01 volumio volumio[923]: info: CorePlayQueue::getTrack 0
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 06 21:54:01 volumio volumio[923]: info: Received Get System Info
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 06 21:54:01 volumio volumio[923]: info: Discovery: Getting this device information
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 06 21:54:01 volumio volumio[923]: info: CorePlayQueue::getTrack 0
Feb 06 21:54:01 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 06 21:54:02 volumio volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 06 21:54:02 volumio volumio[923]: info: CorePlayQueue::getTrack 0
Feb 06 21:54:02 volumio volumio[923]: info: Listing playlists
Feb 06 21:54:02 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 06 21:54:02 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 06 21:54:02 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 06 21:54:02 volumio volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 06 21:54:02 volumio volumio[923]: info: CorePlayQueue::getTrack 0
Feb 06 21:54:03 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Feb 06 21:54:03 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 06 21:54:03 volumio volumio[923]: info: Received Get System Info
Feb 06 21:54:03 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 06 21:54:03 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 06 21:54:03 volumio volumio[923]: info: Discovery: Getting this device information
Feb 06 21:54:03 volumio volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 06 21:54:03 volumio volumio[923]: info: CorePlayQueue::getTrack 0
Feb 06 21:54:03 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 06 21:54:04 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 06 21:54:04 volumio volumio[923]: info: Received Get System Info
Feb 06 21:54:04 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 06 21:54:04 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 06 21:54:04 volumio volumio[923]: info: Discovery: Getting this device information
Feb 06 21:54:04 volumio volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 06 21:54:04 volumio volumio[923]: info: CorePlayQueue::getTrack 0
Feb 06 21:54:04 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 06 21:54:11 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 06 21:54:12 volumio volumio[923]: info: Clearing queue after UPNP request
Feb 06 21:54:12 volumio volumio[923]: info: CoreStateMachine::ClearQueue
Feb 06 21:54:12 volumio volumio[923]: info: CoreStateMachine::stop
Feb 06 21:54:12 volumio volumio[923]: info: CoreStateMachine::setConsumeUpdateService undefined
Feb 06 21:54:12 volumio volumio[923]: info: CorePlayQueue::clearPlayQueue
Feb 06 21:54:12 volumio volumio[923]: info: CorePlayQueue::saveQueue
Feb 06 21:54:12 volumio volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 06 21:54:12 volumio volumio[923]: info: CoreCommandRouter::volumioPushQueue
Feb 06 21:54:12 volumio volumio[923]: error: Upnp client error: Error: This socket has been ended by the other party
Feb 06 21:54:14 volumio volumio[923]: info: Starting UPNP Playback
Feb 06 21:54:14 volumio volumio[923]: info: Preparing playback through UPNP
Feb 06 21:54:14 volumio volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 06 21:54:14 volumio volumio[923]: info: CorePlayQueue::getTrack 0
Feb 06 21:54:14 volumio volumio[923]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 06 21:54:14 volumio volumio[923]: info:
Feb 06 21:54:14 volumio volumio[923]: ---------------------------- MPD announces system playlist update
Feb 06 21:54:14 volumio volumio[923]: info: Ignoring MPD Status Update
Feb 06 21:54:14 volumio volumio[923]: info: ------------------------------ 3ms
Feb 06 21:54:14 volumio volumio[923]: info:
Feb 06 21:54:14 volumio volumio[923]: ---------------------------- MPD announces system playlist update
Feb 06 21:54:14 volumio volumio[923]: info: Ignoring MPD Status Update
Feb 06 21:54:14 volumio volumio[923]: info: ------------------------------ 2ms
Feb 06 21:54:14 volumio volumio[923]: info:
Feb 06 21:54:14 volumio volumio[923]: ---------------------------- MPD announces system playlist update
Feb 06 21:54:14 volumio volumio[923]: info: Ignoring MPD Status Update
Feb 06 21:54:14 volumio volumio[923]: info: ------------------------------ 2ms
Feb 06 21:54:14 volumio volumio[923]: info:
Feb 06 21:54:14 volumio volumio[923]: ---------------------------- MPD announces system playlist update
Feb 06 21:54:14 volumio volumio[923]: info: Ignoring MPD Status Update
Feb 06 21:54:14 volumio volumio[923]: info: ------------------------------ 3ms
Feb 06 21:54:14 volumio volumio[923]: info:
Feb 06 21:54:14 volumio volumio[923]: ---------------------------- MPD announces system playlist update
Feb 06 21:54:14 volumio volumio[923]: info: Ignoring MPD Status Update
Feb 06 21:54:14 volumio volumio[923]: info: ------------------------------ 2ms
Feb 06 21:54:14 volumio volumio[923]: info:
Feb 06 21:54:14 volumio volumio[923]: ---------------------------- MPD announces system playlist update
Feb 06 21:54:14 volumio volumio[923]: info: Ignoring MPD Status Update
Feb 06 21:54:14 volumio volumio[923]: info: ------------------------------ 2ms
Feb 06 21:54:14 volumio volumio[923]: info:
Feb 06 21:54:14 volumio volumio[923]: ---------------------------- MPD announces state update: player
Feb 06 21:54:14 volumio volumio[923]: info: ControllerMpd::getState
Feb 06 21:54:14 volumio volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 06 21:54:14 volumio volumio[923]: info:
Feb 06 21:54:14 volumio volumio[923]: ---------------------------- MPD announces state update: player
Feb 06 21:54:14 volumio volumio[923]: info: sendMpdCommand status took 8 milliseconds
Feb 06 21:54:14 volumio volumio[923]: info: ControllerMpd::getState
Feb 06 21:54:14 volumio volumio[923]: verbose: ControllerMpd::sendMpdCommand status
Feb 06 21:54:14 volumio volumio[923]: verbose: ControllerMpd::parseState
Feb 06 21:54:14 volumio volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 06 21:54:14 volumio volumio[923]: info: sendMpdCommand status took 4 milliseconds
Feb 06 21:54:14 volumio volumio[923]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 06 21:54:14 volumio volumio[923]: verbose: ControllerMpd::parseState
Feb 06 21:54:14 volumio volumio[923]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 06 21:54:14 volumio volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 06 21:54:14 volumio volumio[923]: info: ControllerMpd::pushState
Feb 06 21:54:14 volumio volumio[923]: info: CoreCommandRouter::servicePushState
Feb 06 21:54:15 volumio volumio[923]: verbose: In UPNP mode
Feb 06 21:54:15 volumio volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12174,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"foobar2000 audio stream","artist":null,"album":null,"uri":"http://192.168.0.161:56574/1/stream.wav","trackType":"wav"}
Feb 06 21:54:15 volumio volumio[923]: verbose: CURRENT POSITION 0
Feb 06 21:54:15 volumio volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 06 21:54:15 volumio volumio[923]: info: CoreStateMachine::syncState currentStatus stop
Feb 06 21:54:15 volumio volumio[923]: info: ------------------------------ 28ms
Feb 06 21:54:15 volumio volumio[923]: info: sendMpdCommand playlistinfo took 11 milliseconds
Feb 06 21:54:15 volumio volumio[923]: verbose: ControllerMpd::parseTrackInfo
Feb 06 21:54:15 volumio volumio[923]: info: ControllerMpd::pushState
Feb 06 21:54:15 volumio volumio[923]: info: CoreCommandRouter::servicePushState
Feb 06 21:54:15 volumio volumio[923]: verbose: In UPNP mode
Feb 06 21:54:15 volumio volumio[923]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":12174,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"foobar2000 audio stream","artist":null,"album":null,"uri":"http://192.168.0.161:56574/1/stream.wav","trackType":"wav"}
Feb 06 21:54:15 volumio volumio[923]: verbose: CURRENT POSITION 0
Feb 06 21:54:15 volumio volumio[923]: info: CoreStateMachine::syncState stateService play
Feb 06 21:54:15 volumio volumio[923]: info: CoreStateMachine::syncState currentStatus play
Feb 06 21:54:15 volumio volumio[923]: info: Received an update from plugin. extracting info from payload
Feb 06 21:54:15 volumio volumio[923]: info: CoreStateMachine::pushState
Feb 06 21:54:15 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 06 21:54:15 volumio volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 06 21:54:15 volumio volumio[923]: info: CoreStateMachine::pushState
Feb 06 21:54:15 volumio volumio[923]: info: CoreCommandRouter::volumioPushState
Feb 06 21:54:15 volumio volumio[923]: info: ------------------------------ 60ms
Feb 06 21:54:15 volumio volumio[923]: info: touch_display: Setting screensaver timeout to 0 seconds.
Feb 06 21:54:20 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 06 21:54:20 volumio volumio[923]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Feb 06 21:54:20 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Feb 06 21:54:20 volumio volumio[923]: info: Received Get System Version
Feb 06 21:54:20 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 06 21:54:20 volumio volumio[923]: info: Received Get System Info
Feb 06 21:54:20 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 06 21:54:20 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 06 21:54:20 volumio volumio[923]: info: Discovery: Getting this device information
Feb 06 21:54:20 volumio volumio[923]: info: CoreCommandRouter::volumioGetState
Feb 06 21:54:20 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 21:54:54 volumio volumio[923]: info: Retrieving Cloud Streaming UI
Feb 06 21:54:54 volumio volumio[923]: info: Getting Tidal Cloud Configuration
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 21:54:54 volumio volumio[923]: info: Getting Qobuz Cloud Configuration
Feb 06 21:54:54 volumio volumio[923]: info: Asking plugin for UI Config
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 21:54:54 volumio volumio[923]: info: Getting Spotify Cloud Configuration
Feb 06 21:54:54 volumio volumio[923]: info: Asking plugin for UI Config
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 21:54:54 volumio volumio[923]: info: Saving Spotify Acccount
Feb 06 21:54:54 volumio volumio[923]: info: Got Tidal Cloud Configuration
Feb 06 21:54:54 volumio volumio[923]: info: Got it
Feb 06 21:54:54 volumio volumio[923]: info: Got it
Feb 06 21:54:54 volumio volumio[923]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 06 21:54:54 volumio volumio[923]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 06 21:54:54 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 06 21:54:58 volumio volumio[923]: info: Disabling MyMusic plugin upnp
Feb 06 21:54:58 volumio sudo[22856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Feb 06 21:54:58 volumio sudo[22856]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 06 21:54:58 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD...
Feb 06 21:54:58 volumio volumio[923]: error: Upnp client error: Error: This socket has been ended by the other party
Feb 06 21:54:58 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 06 21:54:59 volumio volumio[923]: info: Enabling MyMusic plugin upnp
Feb 06 21:54:59 volumio volumio[923]: info: Enabling plugin upnp
Feb 06 21:54:59 volumio volumio[923]: info: Loading plugin "upnp"...
Feb 06 21:54:59 volumio volumio[923]: info: [1770432899660] Starting Upmpd Daemon
Feb 06 21:54:59 volumio volumio[923]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 06 21:54:59 volumio volumio[923]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 06 21:54:59 volumio volumio[923]: Error: listen EADDRINUSE: address already in use :::6599
Feb 06 21:54:59 volumio volumio[923]: at Server.setupListenHandle [as _listen2] (net.js:1318:16)
Feb 06 21:54:59 volumio volumio[923]: at listenInCluster (net.js:1366:12)
Feb 06 21:54:59 volumio volumio[923]: at Server.listen (net.js:1452:7)
Feb 06 21:54:59 volumio volumio[923]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Feb 06 21:54:59 volumio volumio[923]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Feb 06 21:54:59 volumio volumio[923]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Feb 06 21:54:59 volumio volumio[923]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Feb 06 21:54:59 volumio volumio[923]: at processTicksAndRejections (internal/process/task_queues.js:75:11) {
Feb 06 21:54:59 volumio volumio[923]: code: 'EADDRINUSE',
Feb 06 21:54:59 volumio volumio[923]: errno: -98,
Feb 06 21:54:59 volumio volumio[923]: syscall: 'listen',
Feb 06 21:54:59 volumio volumio[923]: address: '::',
Feb 06 21:54:59 volumio volumio[923]: port: 6599
Feb 06 21:54:59 volumio volumio[923]: }
Feb 06 21:54:59 volumio volumio[923]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 06 21:55:00 volumio sudo[22882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-06 21:54
Feb 06 21:55:00 volumio sudo[22882]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"