Dec 12 19:36:07 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:07 volumio volumio[1158]: info: CorePlayQueue::getTrack 2
Dec 12 19:36:07 volumio volumio[1158]: info: Listing playlists
Dec 12 19:36:07 volumio volumio[1158]: info: Listing playlists
Dec 12 19:36:13 volumio volumio[1158]: info:
Dec 12 19:36:13 volumio volumio[1158]: ---------------------------- MPD announces system playlist update
Dec 12 19:36:13 volumio volumio[1158]: info: Ignoring MPD Status Update
Dec 12 19:36:13 volumio volumio[1158]: info:
Dec 12 19:36:13 volumio volumio[1158]: ---------------------------- MPD announces state update: player
Dec 12 19:36:13 volumio volumio[1158]: info: ControllerMpd::getState
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 19:36:13 volumio volumio[1158]: error: updateQueue error: null
Dec 12 19:36:13 volumio volumio[1158]: info: ------------------------------ 4ms
Dec 12 19:36:13 volumio volumio[1158]: info: sendMpdCommand status took 2 milliseconds
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::parseState
Dec 12 19:36:13 volumio volumio[1158]: info: ControllerMpd::pushState
Dec 12 19:36:13 volumio volumio[1158]: info: CoreCommandRouter::servicePushState
Dec 12 19:36:13 volumio volumio[1158]: info: CoreStateMachine::pushState
Dec 12 19:36:13 volumio volumio[1158]: info: CorePlayQueue::getTrack 2
Dec 12 19:36:13 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 19:36:13 volumio volumio[1158]: info: CoreCommandRouter::volumioPushState
Dec 12 19:36:13 volumio volumio[1158]: info: CorePlayQueue::getTrack 2
Dec 12 19:36:13 volumio volumio[1158]: 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 12 19:36:13 volumio volumio[1158]: verbose: CURRENT POSITION 2
Dec 12 19:36:13 volumio volumio[1158]: info: CoreStateMachine::syncState stateService stop
Dec 12 19:36:13 volumio volumio[1158]: info: CoreStateMachine::syncState currentStatus play
Dec 12 19:36:13 volumio volumio[1158]: info: CoreStateMachine::play index undefined
Dec 12 19:36:13 volumio volumio[1158]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 19:36:13 volumio volumio[1158]: info: CoreStateMachine::pushState
Dec 12 19:36:13 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:13 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 19:36:13 volumio volumio[1158]: info: CoreCommandRouter::volumioPushState
Dec 12 19:36:13 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:13 volumio volumio[1158]: info: CoreStateMachine::startPlaybackTimer
Dec 12 19:36:13 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::clearAddPlayTracks NAS/music_temp/Lady Gaga/MAYHEM/04 Perfect Celebrity.flac
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 19:36:13 volumio volumio[1158]: info: ------------------------------ 16ms
Dec 12 19:36:13 volumio volumio[1158]: info: CoreStateMachine::pushState
Dec 12 19:36:13 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:13 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 19:36:13 volumio volumio[1158]: info: CoreCommandRouter::volumioPushState
Dec 12 19:36:13 volumio volumio[1158]: info: sendMpdCommand stop took 4 milliseconds
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::sendMpdCommand clear
Dec 12 19:36:13 volumio volumio[1158]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35
Dec 12 19:36:13 volumio volumio[1158]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35
Dec 12 19:36:13 volumio volumio[1158]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35
Dec 12 19:36:13 volumio volumio[1158]: info:
Dec 12 19:36:13 volumio volumio[1158]: ---------------------------- MPD announces system playlist update
Dec 12 19:36:13 volumio volumio[1158]: info: Ignoring MPD Status Update
Dec 12 19:36:13 volumio volumio[1158]: info: sendMpdCommand clear took 5 milliseconds
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::sendMpdCommand add "NAS/music_temp/Lady Gaga/MAYHEM/04 Perfect Celebrity.flac"
Dec 12 19:36:13 volumio volumio[1158]: error: updateQueue error: null
Dec 12 19:36:13 volumio volumio[1158]: info:
Dec 12 19:36:13 volumio volumio[1158]: ---------------------------- MPD announces system playlist update
Dec 12 19:36:13 volumio volumio[1158]: info: Ignoring MPD Status Update
Dec 12 19:36:13 volumio volumio[1158]: info: ------------------------------ 2ms
Dec 12 19:36:13 volumio volumio[1158]: info: sendMpdCommand add "NAS/music_temp/Lady Gaga/MAYHEM/04 Perfect Celebrity.flac" took 1 milliseconds
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::sendMpdCommand play
Dec 12 19:36:13 volumio volumio[1158]: info: ------------------------------ 2ms
Dec 12 19:36:13 volumio volumio[1158]: info: sendMpdCommand play took 2 milliseconds
Dec 12 19:36:13 volumio volumio[1158]: info:
Dec 12 19:36:13 volumio volumio[1158]: ---------------------------- MPD announces state update: player
Dec 12 19:36:13 volumio volumio[1158]: info: ControllerMpd::getState
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 19:36:13 volumio volumio[1158]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Dec 12 19:36:13 volumio volumio[1158]: info: FusionDsp - ---- read samplerate from file: 44100
Dec 12 19:36:13 volumio volumio[1158]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Dec 12 19:36:13 volumio volumio[1158]: info:
Dec 12 19:36:13 volumio volumio[1158]: ---------------------------- MPD announces state update: player
Dec 12 19:36:13 volumio volumio[1158]: info: sendMpdCommand status took 10 milliseconds
Dec 12 19:36:13 volumio volumio[1158]: info: ControllerMpd::getState
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::parseState
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 19:36:13 volumio volumio[1158]: info: sendMpdCommand status took 5 milliseconds
Dec 12 19:36:13 volumio volumio[1158]: info: sendMpdCommand playlistinfo took 5 milliseconds
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::parseState
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 19:36:13 volumio volumio[1158]: verbose: ControllerMpd::parseTrackInfo
Dec 12 19:36:13 volumio volumio[1158]: info: ControllerMpd::pushState
Dec 12 19:36:13 volumio volumio[1158]: info: CoreCommandRouter::servicePushState
Dec 12 19:36:13 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:13 volumio volumio[1158]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Perfect Celebrity","artist":"Lady Gaga","album":"MAYHEM","uri":"NAS/music_temp/Lady Gaga/MAYHEM/04 Perfect Celebrity.flac","trackType":"flac"}
Dec 12 19:36:13 volumio volumio[1158]: verbose: CURRENT POSITION 3
Dec 12 19:36:14 volumio volumio[1158]: info: CoreStateMachine::syncState stateService play
Dec 12 19:36:14 volumio volumio[1158]: info: CoreStateMachine::syncState currentStatus stop
Dec 12 19:36:14 volumio volumio[1158]: info: ------------------------------ 20ms
Dec 12 19:36:14 volumio volumio[1158]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 12 19:36:14 volumio volumio[1158]: verbose: ControllerMpd::parseTrackInfo
Dec 12 19:36:14 volumio volumio[1158]: info: ControllerMpd::pushState
Dec 12 19:36:14 volumio volumio[1158]: info: CoreCommandRouter::servicePushState
Dec 12 19:36:14 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:14 volumio volumio[1158]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Perfect Celebrity","artist":"Lady Gaga","album":"MAYHEM","uri":"NAS/music_temp/Lady Gaga/MAYHEM/04 Perfect Celebrity.flac","trackType":"flac"}
Dec 12 19:36:14 volumio volumio[1158]: verbose: CURRENT POSITION 3
Dec 12 19:36:14 volumio volumio[1158]: info: CoreStateMachine::syncState stateService play
Dec 12 19:36:14 volumio volumio[1158]: info: CoreStateMachine::syncState currentStatus play
Dec 12 19:36:14 volumio volumio[1158]: info: Received an update from plugin. extracting info from payload
Dec 12 19:36:14 volumio volumio[1158]: info: CoreStateMachine::pushState
Dec 12 19:36:14 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:14 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 19:36:14 volumio volumio[1158]: info: CoreCommandRouter::volumioPushState
Dec 12 19:36:14 volumio volumio[1158]: info: CoreStateMachine::pushState
Dec 12 19:36:14 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:14 volumio volumio[1158]: info: CoreCommandRouter::volumioPushState
Dec 12 19:36:14 volumio volumio[1158]: info: ------------------------------ 21ms
Dec 12 19:36:14 volumio volumio[1158]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35
Dec 12 19:36:14 volumio volumio[1158]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35
Dec 12 19:36:14 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 12 19:36:14 volumio volumio[1158]: info: [now-playing] Fetch metadata (DefaultMetadataProvider): {"type":"song","name":"Perfect Celebrity","artist":"Lady Gaga","album":"MAYHEM","duration":"229","uri":"mnt/NAS/music_temp/Lady Gaga/MAYHEM/04 Perfect Celebrity.flac","service":""}
Dec 12 19:36:14 volumio volumio[1158]: info: [now-playing] LRCLIB getLyrics(): song: "Perfect Celebrity" album: "MAYHEM" artist: "Lady Gaga" duration: "229"
Dec 12 19:36:14 volumio volumio[1158]: info: [now-playing] LRCLIB getLyrics() API URL: https://lrclib.net/api/get?track_name=Perfect+Celebrity&artist_name=Lady+Gaga&album_name=MAYHEM&duration=229
Dec 12 19:36:15 volumio go-librespot[1583]: time="2025-12-12T19:36:15+01:00" level=trace msg="sent dealer ping"
Dec 12 19:36:15 volumio go-librespot[1583]: time="2025-12-12T19:36:15+01:00" level=trace msg="received dealer pong"
Dec 12 19:36:17 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:17 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:27 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:27 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:27 volumio volumio[1158]: info: Listing playlists
Dec 12 19:36:27 volumio volumio[1158]: info: Listing playlists
Dec 12 19:36:37 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:37 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:45 volumio go-librespot[1583]: time="2025-12-12T19:36:45+01:00" level=trace msg="sent dealer ping"
Dec 12 19:36:45 volumio go-librespot[1583]: time="2025-12-12T19:36:45+01:00" level=trace msg="received dealer pong"
Dec 12 19:36:47 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:47 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:47 volumio volumio[1158]: info: Listing playlists
Dec 12 19:36:47 volumio volumio[1158]: info: Listing playlists
Dec 12 19:36:48 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 12 19:36:48 volumio volumio[1158]: info: [now-playing] Fetch metadata (DefaultMetadataProvider): {"type":"song","name":"Perfect Celebrity","artist":"Lady Gaga","album":"MAYHEM","duration":"229","uri":"mnt/NAS/music_temp/Lady Gaga/MAYHEM/04 Perfect Celebrity.flac","service":""}
Dec 12 19:36:50 volumio sudo[28017]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 12 19:36:50 volumio sudo[28015]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 12 19:36:50 volumio sudo[28017]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 12 19:36:50 volumio sudo[28015]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 12 19:36:50 volumio sudo[28017]: pam_unix(sudo:session): session closed for user root
Dec 12 19:36:50 volumio sudo[28015]: pam_unix(sudo:session): session closed for user root
Dec 12 19:36:50 volumio volumio[1158]: verbose: New Socket.io Connection to 192.168.1.142 from 192.168.1.2 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Dec 12 19:36:51 volumio sudo[28025]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 12 19:36:51 volumio sudo[28025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 12 19:36:51 volumio sudo[28025]: pam_unix(sudo:session): session closed for user root
Dec 12 19:36:51 volumio sudo[28027]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 12 19:36:51 volumio sudo[28027]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 12 19:36:51 volumio sudo[28027]: pam_unix(sudo:session): session closed for user root
Dec 12 19:36:51 volumio volumio[1158]: verbose: New Socket.io Connection to 192.168.1.142 from 192.168.1.2 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:51 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 12 19:36:51 volumio volumio[1158]: info: Received Get System Info
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 12 19:36:51 volumio volumio[1158]: info: Discovery: Getting this device information
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:51 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:51 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:51 volumio volumio[1158]: info: Listing playlists
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:36:51 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 12 19:36:52 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:52 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:52 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Dec 12 19:36:53 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 12 19:36:53 volumio volumio[1158]: info: Received Get System Info
Dec 12 19:36:53 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 12 19:36:53 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 12 19:36:53 volumio volumio[1158]: info: Discovery: Getting this device information
Dec 12 19:36:53 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:53 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:53 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 12 19:36:54 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 12 19:36:54 volumio volumio[1158]: info: Received Get System Info
Dec 12 19:36:54 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 12 19:36:54 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 12 19:36:54 volumio volumio[1158]: info: Discovery: Getting this device information
Dec 12 19:36:54 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:54 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:36:54 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:36:57 volumio volumio[1158]: info: Retrieving Cloud Streaming UI
Dec 12 19:36:57 volumio volumio[1158]: info: Getting Tidal Cloud Configuration
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:36:57 volumio volumio[1158]: info: Getting Qobuz Cloud Configuration
Dec 12 19:36:57 volumio volumio[1158]: info: Asking plugin for UI Config
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:36:57 volumio volumio[1158]: info: Getting Spotify Cloud Configuration
Dec 12 19:36:57 volumio volumio[1158]: info: Asking plugin for UI Config
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:36:57 volumio volumio[1158]: info: Saving Spotify Acccount
Dec 12 19:36:57 volumio volumio[1158]: info: Got Tidal Cloud Configuration
Dec 12 19:36:57 volumio volumio[1158]: info: Got it
Dec 12 19:36:57 volumio volumio[1158]: info: Got it
Dec 12 19:36:57 volumio volumio[1158]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 12 19:36:57 volumio volumio[1158]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Dec 12 19:36:57 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:36:57 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:37:01 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Dec 12 19:37:01 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 12 19:37:05 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 12 19:37:07 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:37:07 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:37:07 volumio volumio[1158]: info: Listing playlists
Dec 12 19:37:07 volumio volumio[1158]: info: Listing playlists
Dec 12 19:37:09 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Dec 12 19:37:09 volumio volumio[1158]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Dec 12 19:37:09 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Dec 12 19:37:09 volumio volumio[1158]: info: Received Get System Version
Dec 12 19:37:09 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 12 19:37:09 volumio volumio[1158]: info: Received Get System Info
Dec 12 19:37:09 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 12 19:37:09 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 12 19:37:09 volumio volumio[1158]: info: Discovery: Getting this device information
Dec 12 19:37:09 volumio volumio[1158]: info: CoreCommandRouter::volumioGetState
Dec 12 19:37:09 volumio volumio[1158]: info: CorePlayQueue::getTrack 3
Dec 12 19:37:09 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 12 19:37:09 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 12 19:37:12 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Dec 12 19:37:12 volumio volumio[1158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Dec 12 19:37:12 volumio systemd[1]: avahi-daemon.service: Main process exited, code=killed, status=11/SEGV
Dec 12 19:37:12 volumio systemd[1]: avahi-daemon.service: Failed with result 'signal'.
Dec 12 19:37:12 volumio systemd[1]: avahi-daemon.service: Consumed 10.227s CPU time.
Dec 12 19:37:12 volumio volumio[1158]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 12 19:37:12 volumio dbus-daemon[734]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.24' (uid=104 pid=1702 comm="/usr/bin/shairport-sync --configfile=/tmp/shairpor")
Dec 12 19:37:12 volumio volumio[1158]: Error: getaddrinfo -3007
Dec 12 19:37:12 volumio volumio[1158]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Dec 12 19:37:12 volumio volumio[1158]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Dec 12 19:37:12 volumio volumio[1158]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Dec 12 19:37:12 volumio volumio[1158]: code: -3007,
Dec 12 19:37:12 volumio volumio[1158]: errno: -3007,
Dec 12 19:37:12 volumio volumio[1158]: syscall: 'getaddrinfo'
Dec 12 19:37:12 volumio volumio[1158]: }
Dec 12 19:37:12 volumio volumio[1158]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 12 19:37:12 volumio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack...
Dec 12 19:37:13 volumio avahi-daemon[28137]: Process 732 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid)
Dec 12 19:37:13 volumio avahi-daemon[28137]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109).
Dec 12 19:37:13 volumio avahi-daemon[28137]: Successfully dropped root privileges.
Dec 12 19:37:13 volumio avahi-daemon[28137]: avahi-daemon 0.8 starting up.
Dec 12 19:37:13 volumio dbus-daemon[734]: [system] Successfully activated service 'org.freedesktop.Avahi'
Dec 12 19:37:13 volumio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack.
Dec 12 19:37:13 volumio avahi-daemon[28137]: Successfully called chroot().
Dec 12 19:37:13 volumio avahi-daemon[28137]: Successfully dropped remaining capabilities.
Dec 12 19:37:13 volumio avahi-daemon[28137]: No service file found in /etc/avahi/services.
Dec 12 19:37:13 volumio avahi-daemon[28137]: *** WARNING: Detected another IPv4 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. ***
Dec 12 19:37:13 volumio avahi-daemon[28137]: *** WARNING: Detected another IPv6 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. ***
Dec 12 19:37:13 volumio avahi-daemon[28137]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.142.
Dec 12 19:37:13 volumio avahi-daemon[28137]: New relevant interface eth0.IPv4 for mDNS.
Dec 12 19:37:13 volumio avahi-daemon[28137]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1.
Dec 12 19:37:13 volumio avahi-daemon[28137]: New relevant interface lo.IPv4 for mDNS.
Dec 12 19:37:13 volumio avahi-daemon[28137]: Network interface enumeration completed.
Dec 12 19:37:13 volumio avahi-daemon[28137]: Registering new address record for 192.168.1.142 on eth0.IPv4.
Dec 12 19:37:13 volumio avahi-daemon[28137]: Registering new address record for 127.0.0.1 on lo.IPv4.
Dec 12 19:37:13 volumio avahi-daemon[28137]: Server startup complete. Host name is volumio.local. Local service cookie is 1406301968.
Dec 12 19:37:14 volumio sudo[28153]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-12 19:36'
Dec 12 19:37:14 volumio sudo[28153]: 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="140c1549b54b48087be58e6d122fe2155a57ac20"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Dec 11 18:08:21 UTC 2025"
VOLUMIO_VERSION="4.080"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="c84e943fcb997d76b00264035c7241c7"