Dec 24 14:41:04 volumio volumio[1186]: info: CALLMETHOD: audio_interface fusiondsp saveequalizerpreset [object Object]
Dec 24 14:41:04 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , saveequalizerpreset
Dec 24 14:41:04 volumio volumio[1186]: warn: FusionDsp - File "/data/INTERNAL/FusionDsp/presets/EQ15/miconfig.json" already exists. Overwriting...
Dec 24 14:41:05 volumio volumio[1186]: info: CALLMETHOD: audio_interface fusiondsp saveequalizerpresetv undefined
Dec 24 14:41:05 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , saveequalizerpresetv
Dec 24 14:41:05 volumio volumio[1186]: info: FusionDsp - File "/data/INTERNAL/FusionDsp/presets/EQ15/miconfig.json" created successfully.
Dec 24 14:41:06 volumio volumio[1186]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 24 14:41:06 volumio volumio[1186]: info: CoreCommandRouter::Close All Modals sent
Dec 24 14:41:08 volumio volumio[1186]: info: CALLMETHOD: audio_interface fusiondsp usethispreset [object Object]
Dec 24 14:41:08 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , usethispreset
Dec 24 14:41:08 volumio volumio[1186]: info: FusionDsp - Value for usedpreset:
Dec 24 14:41:08 volumio volumio[1186]: error: FusionDsp - Value reading JSON file: {"geq15":"2.5,2.5,2,1,0,-1,-2.5,-2.5,-2,-1,0,1.5,3,3.5,3","state4preset":["jameier",false,false,24,0,0,0,"None",true,false,false,0,0,false],"x2geq15":"2.5,2.5,2,1,0,-1,-2.5,-2.5,-2,-1,0,1.5,3,3.5,3"}
Dec 24 14:41:08 volumio volumio[1186]: info: FusionDsp - geq15 2.5,2.5,2,1,0,-1,-2.5,-2.5,-2,-1,0,1.5,3,3.5,3
Dec 24 14:41:08 volumio volumio[1186]: info: FusionDsp - value state4preset jameier,false,false,24,0,0,0,None,true,false,false,0,0,false
Dec 24 14:41:09 volumio volumio[1186]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Dec 24 14:41:09 volumio volumio[1186]: info: FusionDsp - crossfeed jameier
Dec 24 14:41:09 volumio volumio[1186]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 24 14:41:09 volumio volumio[1186]: info: CoreCommandRouter::Close All Modals sent
Dec 24 14:41:10 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:41:12 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:41:12 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:41:12 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:41:12 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:41:12 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:41:12 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:41:13 volumio go-librespot[1521]: time="2025-12-24T14:41:13-03:00" level=trace msg="sent dealer ping"
Dec 24 14:41:13 volumio go-librespot[1521]: time="2025-12-24T14:41:13-03:00" level=trace msg="received dealer pong"
Dec 24 14:41:18 volumio volumio[1186]: info: CorePlayQueue::getTrack 6
Dec 24 14:41:18 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: tidal , goto
Dec 24 14:41:19 volumio volumio[1186]: info: explodeTIDALUri took 459 milliseconds
Dec 24 14:41:19 volumio volumio[1186]: info: browseTIDALUri took 261 milliseconds
Dec 24 14:41:19 volumio volumio[1186]: info: Executing endpoint getSimilarAlbums
Dec 24 14:41:19 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Dec 24 14:41:19 volumio volumio[1186]: info: Executing endpoint getSimilarAlbums
Dec 24 14:41:19 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Dec 24 14:41:19 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:41:19 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:41:19 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:41:19 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:41:19 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:41:19 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:41:19 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:41:19 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:41:26 volumio volumio[1186]: info: Preload queue cleared
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::ClearQueue
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::stop
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::stPlaybackTimer
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::updateTrackBlock
Dec 24 14:41:26 volumio volumio[1186]: info: CorePlayQueue::getTrackBlock
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::pushState
Dec 24 14:41:26 volumio volumio[1186]: info: CorePlayQueue::getTrack 6
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
Dec 24 14:41:26 volumio volumio[1186]: info: MRS: Pushing multiroomSync output update for this device
Dec 24 14:41:26 volumio volumio[1186]: info: MRS: Pushing multiroomSync output
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:41:26 volumio volumio[1186]: info: CorePlayQueue::getTrack 6
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::serviceStop
Dec 24 14:41:26 volumio volumio[1186]: info: CorePlayQueue::getTrack 6
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::serviceStop
Dec 24 14:41:26 volumio volumio[1186]: info: [1766598086766] ControllerTidal::stop
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 24 14:41:26 volumio volumio[1186]: info: ControllerMpd::stop
Dec 24 14:41:26 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand stop
Dec 24 14:41:26 volumio volumio[1186]: info: CorePlayQueue::clearPlayQueue
Dec 24 14:41:26 volumio volumio[1186]: info: CorePlayQueue::saveQueue
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioPushQueue
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::addQueueItems
Dec 24 14:41:26 volumio volumio[1186]: info: CorePlayQueue::addQueueItems
Dec 24 14:41:26 volumio volumio[1186]: info: Preload queue cleared
Dec 24 14:41:26 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527023
Dec 24 14:41:26 volumio volumio[1186]: info: Exploding uri tidal://song/319527023 in service tidal
Dec 24 14:41:26 volumio volumio[1186]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60
Dec 24 14:41:26 volumio volumio[1186]: info:
Dec 24 14:41:26 volumio volumio[1186]: ---------------------------- MPD announces state update: player
Dec 24 14:41:26 volumio volumio[1186]: info: sendMpdCommand stop took 63 milliseconds
Dec 24 14:41:26 volumio volumio[1186]: info: ControllerMpd::getState
Dec 24 14:41:26 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand status
Dec 24 14:41:26 volumio volumio[1186]: info: sendMpdCommand status took 3 milliseconds
Dec 24 14:41:26 volumio volumio[1186]: verbose: ControllerMpd::parseState
Dec 24 14:41:26 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 24 14:41:26 volumio volumio[1186]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 24 14:41:26 volumio volumio[1186]: verbose: ControllerMpd::parseTrackInfo
Dec 24 14:41:26 volumio volumio[1186]: info: ControllerMpd::pushState
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::servicePushState
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::pushState
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
Dec 24 14:41:26 volumio volumio[1186]: info: MRS: Pushing multiroomSync output update for this device
Dec 24 14:41:26 volumio volumio[1186]: info: MRS: Pushing multiroomSync output
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:41:26 volumio volumio[1186]: info: CorePlayQueue::getTrack 6
Dec 24 14:41:26 volumio volumio[1186]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1766601598~ZjE1MjViNWM1MGUzMDE2Njk1Y2FhMzE2YzE2MTNiNWNlZjE2YWQyYg==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEicyY2UzM2JjNDkwZjY0NTgwMTFmNDViOGUxODA2YTFmM182MS5tcDQ/0.flac?token=1766601598~ZjE1MjViNWM1MGUzMDE2Njk1Y2FhMzE2YzE2MTNiNWNlZjE2YWQyYg==","trackType":"tidal"}
Dec 24 14:41:26 volumio volumio[1186]: verbose: CURRENT POSITION 6
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::syncState stateService stop
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::syncState currentStatus stop
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::pushState
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
Dec 24 14:41:26 volumio volumio[1186]: info: MRS: Pushing multiroomSync output update for this device
Dec 24 14:41:26 volumio volumio[1186]: info: MRS: Pushing multiroomSync output
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:41:26 volumio volumio[1186]: info: No code
Dec 24 14:41:26 volumio volumio[1186]: info: CoreStateMachine::pushState
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
Dec 24 14:41:26 volumio volumio[1186]: info: MRS: Pushing multiroomSync output update for this device
Dec 24 14:41:26 volumio volumio[1186]: info: MRS: Pushing multiroomSync output
Dec 24 14:41:26 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:41:26 volumio volumio[1186]: info: ------------------------------ 86ms
Dec 24 14:41:26 volumio volumio[1186]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60
Dec 24 14:41:26 volumio volumio[1186]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60
Dec 24 14:41:26 volumio volumio[1186]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60
Dec 24 14:41:27 volumio volumio[1186]: info: explodeTIDALUri took 583 milliseconds
Dec 24 14:41:27 volumio volumio[1186]: info: CoreCommandRouter::volumioPushQueue
Dec 24 14:41:27 volumio volumio[1186]: info: CorePlayQueue::saveQueue
Dec 24 14:41:27 volumio volumio[1186]: info: CoreStateMachine::updateTrackBlock
Dec 24 14:41:27 volumio volumio[1186]: info: CorePlayQueue::getTrackBlock
Dec 24 14:41:27 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:41:27 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: play , [object Object]
Dec 24 14:41:27 volumio volumio[1186]: info: CoreCommandRouter::volumioPlay
Dec 24 14:41:27 volumio volumio[1186]: info: CoreStateMachine::play index 0
Dec 24 14:41:27 volumio volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 24 14:41:27 volumio volumio[1186]: info: CoreStateMachine::addQueueItems
Dec 24 14:41:27 volumio volumio[1186]: info: CorePlayQueue::addQueueItems
Dec 24 14:41:27 volumio volumio[1186]: info: Preload queue cleared
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527024
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527024 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527025
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527025 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527026
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527026 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527027
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527027 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527028
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527028 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527029
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527029 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527030
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527030 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527031
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527031 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527032
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527032 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527033
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527033 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527034
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527034 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527035
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527035 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527036
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527036 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527037
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527037 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527038
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527038 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527039
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527039 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527040
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527040 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527041
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527041 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527042
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527042 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527043
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527043 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527044
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527044 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527045
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527045 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527046
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527046 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527047
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527047 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527048
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527048 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527049
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527049 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527050
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527050 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527051
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527051 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527052
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527052 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: Adding Item to queue: tidal://song/319527053
Dec 24 14:41:27 volumio volumio[1186]: info: Exploding uri tidal://song/319527053 in service tidal
Dec 24 14:41:27 volumio volumio[1186]: info: CoreStateMachine::stop
Dec 24 14:41:27 volumio volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 24 14:41:27 volumio volumio[1186]: info: CoreStateMachine::play index undefined
Dec 24 14:41:27 volumio volumio[1186]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 24 14:41:27 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
Dec 24 14:41:27 volumio volumio[1186]: info: CoreStateMachine::startPlaybackTimer
Dec 24 14:41:27 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
Dec 24 14:41:27 volumio volumio[1186]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 24 14:41:27 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 24 14:41:27 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Dec 24 14:41:27 volumio volumio[1186]: info: [1766598087450] ControllerTidal::clearAddPlayTrack
Dec 24 14:41:27 volumio volumio[1186]: info: Getting stream with soundQuality HI_RES
Dec 24 14:41:27 volumio volumio[1186]: info: explodeTIDALUri took 269 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 718 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 749 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1062 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1119 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1113 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1149 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1156 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1155 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1155 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1157 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1159 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1161 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1162 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1218 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1226 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1222 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1229 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1233 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1234 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1259 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1300 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1309 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1341 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1360 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1387 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1423 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1449 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1510 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: explodeTIDALUri took 1539 milliseconds
Dec 24 14:41:28 volumio volumio[1186]: info: CoreCommandRouter::volumioPushQueue
Dec 24 14:41:29 volumio volumio[1186]: info: CorePlayQueue::saveQueue
Dec 24 14:41:29 volumio volumio[1186]: info: CoreStateMachine::updateTrackBlock
Dec 24 14:41:29 volumio volumio[1186]: info: CorePlayQueue::getTrackBlock
Dec 24 14:41:29 volumio volumio[1186]: info: getStreamUrl took 1913 milliseconds
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand stop
Dec 24 14:41:29 volumio volumio[1186]: info: sendMpdCommand stop took 1 milliseconds
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand clear
Dec 24 14:41:29 volumio volumio[1186]: info:
Dec 24 14:41:29 volumio volumio[1186]: ---------------------------- MPD announces system playlist update
Dec 24 14:41:29 volumio volumio[1186]: info: Ignoring MPD Status Update
Dec 24 14:41:29 volumio volumio[1186]: info: sendMpdCommand clear took 1 milliseconds
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidhYmYwNDg1NTAyOGM1ZTA3OWQ5ZmFhODc0YWNmZWExZV82MS5tcDQ/0.flac?token=1766601689~MTM2ZjczYjA5YjllZDdhNWNkODRhZGRjYzU4MTczYjU4NWJjMjVmZA=="
Dec 24 14:41:29 volumio volumio[1186]: error: updateQueue error: null
Dec 24 14:41:29 volumio volumio[1186]: info:
Dec 24 14:41:29 volumio volumio[1186]: ---------------------------- MPD announces system playlist update
Dec 24 14:41:29 volumio volumio[1186]: info: Ignoring MPD Status Update
Dec 24 14:41:29 volumio volumio[1186]: info: ------------------------------ 5ms
Dec 24 14:41:29 volumio volumio[1186]: info: sendMpdCommand add "http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidhYmYwNDg1NTAyOGM1ZTA3OWQ5ZmFhODc0YWNmZWExZV82MS5tcDQ/0.flac?token=1766601689~MTM2ZjczYjA5YjllZDdhNWNkODRhZGRjYzU4MTczYjU4NWJjMjVmZA==" took 4 milliseconds
Dec 24 14:41:29 volumio volumio[1186]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand play
Dec 24 14:41:29 volumio volumio[1186]: info: ------------------------------ 4ms
Dec 24 14:41:29 volumio volumio[1186]: info: sendMpdCommand play took 3 milliseconds
Dec 24 14:41:29 volumio volumio[1186]: info:
Dec 24 14:41:29 volumio volumio[1186]: ---------------------------- MPD announces state update: player
Dec 24 14:41:29 volumio volumio[1186]: info: ControllerMpd::getState
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand status
Dec 24 14:41:29 volumio volumio[1186]: info: FusionDsp - ---- read samplerate, raw:
Dec 24 14:41:29 volumio volumio[1186]: error: FusionDsp - invalid sample rate
Dec 24 14:41:29 volumio volumio[1186]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Dec 24 14:41:29 volumio volumio[1186]: info: FusionDsp - ---- read samplerate from file: 44100
Dec 24 14:41:29 volumio volumio[1186]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Dec 24 14:41:29 volumio volumio[1186]: info: FusionDsp - crossfeed jameier
Dec 24 14:41:29 volumio volumio[1186]: info:
Dec 24 14:41:29 volumio volumio[1186]: ---------------------------- MPD announces state update: player
Dec 24 14:41:29 volumio volumio[1186]: info: sendMpdCommand status took 33 milliseconds
Dec 24 14:41:29 volumio volumio[1186]: info: ControllerMpd::getState
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand status
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::parseState
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 24 14:41:29 volumio volumio[1186]: info: sendMpdCommand status took 6 milliseconds
Dec 24 14:41:29 volumio volumio[1186]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::parseState
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::parseTrackInfo
Dec 24 14:41:29 volumio volumio[1186]: info: ControllerMpd::pushState
Dec 24 14:41:29 volumio volumio[1186]: info: CoreCommandRouter::servicePushState
Dec 24 14:41:29 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
Dec 24 14:41:29 volumio volumio[1186]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":584,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"0.flac?token=1766601689~MTM2ZjczYjA5YjllZDdhNWNkODRhZGRjYzU4MTczYjU4NWJjMjVmZA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidhYmYwNDg1NTAyOGM1ZTA3OWQ5ZmFhODc0YWNmZWExZV82MS5tcDQ/0.flac?token=1766601689~MTM2ZjczYjA5YjllZDdhNWNkODRhZGRjYzU4MTczYjU4NWJjMjVmZA==","trackType":"tidal"}
Dec 24 14:41:29 volumio volumio[1186]: verbose: CURRENT POSITION 0
Dec 24 14:41:29 volumio volumio[1186]: info: CoreStateMachine::syncState stateService play
Dec 24 14:41:29 volumio volumio[1186]: info: CoreStateMachine::syncState currentStatus stop
Dec 24 14:41:29 volumio volumio[1186]: info: ------------------------------ 49ms
Dec 24 14:41:29 volumio volumio[1186]: info: sendMpdCommand playlistinfo took 6 milliseconds
Dec 24 14:41:29 volumio volumio[1186]: verbose: ControllerMpd::parseTrackInfo
Dec 24 14:41:29 volumio volumio[1186]: info: ControllerMpd::pushState
Dec 24 14:41:29 volumio volumio[1186]: info: CoreCommandRouter::servicePushState
Dec 24 14:41:29 volumio volumio[1186]: info: CorePlayQueue::getTrack 0
Dec 24 14:41:29 volumio volumio[1186]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":584,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"494 Kbps","isStreaming":false,"title":"0.flac?token=1766601689~MTM2ZjczYjA5YjllZDdhNWNkODRhZGRjYzU4MTczYjU4NWJjMjVmZA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidhYmYwNDg1NTAyOGM1ZTA3OWQ5ZmFhODc0YWNmZWExZV82MS5tcDQ/0.flac?token=1766601689~MTM2ZjczYjA5YjllZDdhNWNkODRhZGRjYzU4MTczYjU4NWJjMjVmZA==","trackType":"tidal"}
Dec 24 14:41:29 volumio volumio[1186]: verbose: CURRENT POSITION 0
Dec 24 14:41:29 volumio volumio[1186]: info: CoreStateMachine::syncState stateService play
Dec 24 14:41:29 volumio volumio[1186]: info: CoreStateMachine::syncState currentStatus play
Dec 24 14:41:29 volumio volumio[1186]: info: Received an update from plugin. extracting info from payload
Dec 24 14:41:29 volumio volumio[1186]: info: CoreStateMachine::pushState
Dec 24 14:41:29 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 24 14:41:29 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
Dec 24 14:41:29 volumio volumio[1186]: info: MRS: Pushing multiroomSync output update for this device
Dec 24 14:41:29 volumio volumio[1186]: info: MRS: Pushing multiroomSync output
Dec 24 14:41:29 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:41:29 volumio volumio[1186]: info: CoreStateMachine::pushState
Dec 24 14:41:29 volumio volumio[1186]: info: CoreCommandRouter::volumioPushState
Dec 24 14:41:29 volumio volumio[1186]: info: MRS: Pushing multiroomSync output update for this device
Dec 24 14:41:29 volumio volumio[1186]: info: MRS: Pushing multiroomSync output
Dec 24 14:41:29 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:41:29 volumio volumio[1186]: info: ------------------------------ 72ms
Dec 24 14:41:29 volumio volumio[1186]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60
Dec 24 14:41:29 volumio volumio[1186]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60
Dec 24 14:41:42 volumio go-librespot[1521]: time="2025-12-24T14:41:42-03:00" level=trace msg="received accesspoint ping"
Dec 24 14:41:42 volumio systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories...
Dec 24 14:41:42 volumio systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully.
Dec 24 14:41:42 volumio systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories.
Dec 24 14:41:42 volumio systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully.
Dec 24 14:41:42 volumio go-librespot[1521]: time="2025-12-24T14:41:42-03:00" level=trace msg="received accesspoint pong ack"
Dec 24 14:41:43 volumio go-librespot[1521]: time="2025-12-24T14:41:43-03:00" level=trace msg="sent dealer ping"
Dec 24 14:41:43 volumio go-librespot[1521]: time="2025-12-24T14:41:43-03:00" level=trace msg="received dealer pong"
Dec 24 14:42:06 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:42:07 volumio volumio[1186]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 24 14:42:07 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 24 14:42:07 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Dec 24 14:42:07 volumio sudo[3665]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Dec 24 14:42:07 volumio sudo[3665]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:07 volumio sudo[3670]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 24 14:42:07 volumio sudo[3670]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:07 volumio sudo[3670]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:07 volumio sudo[3665]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:07 volumio sudo[3678]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 24 14:42:07 volumio sudo[3678]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:07 volumio sudo[3678]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:07 volumio sudo[3684]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Dec 24 14:42:07 volumio sudo[3684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:07 volumio sudo[3684]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:07 volumio sudo[3691]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 24 14:42:07 volumio sudo[3691]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:07 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Dec 24 14:42:07 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Dec 24 14:42:07 volumio sudo[3691]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:07 volumio sudo[3693]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 24 14:42:07 volumio sudo[3693]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:07 volumio sudo[3693]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:07 volumio sudo[3697]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Dec 24 14:42:07 volumio sudo[3697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:08 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:42:08 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:42:08 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:42:08 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:42:08 volumio volumio[1186]: info: Executing endpoint metavolumio
Dec 24 14:42:08 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Dec 24 14:42:10 volumio sudo[3697]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:10 volumio volumio[1186]: verbose: New Socket.io Connection to 192.168.1.4:3000 from 192.168.1.2 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9
Dec 24 14:42:10 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 24 14:42:10 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 24 14:42:10 volumio volumio[1186]: info: Discovery: Getting this device information
Dec 24 14:42:10 volumio volumio[1186]: info: CoreCommandRouter::volumioGetState
Dec 24 14:42:10 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 24 14:42:13 volumio go-librespot[1521]: time="2025-12-24T14:42:13-03:00" level=trace msg="sent dealer ping"
Dec 24 14:42:13 volumio go-librespot[1521]: time="2025-12-24T14:42:13-03:00" level=trace msg="received dealer pong"
Dec 24 14:42:36 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings
Dec 24 14:42:36 volumio volumio[1186]: info: Saving new wireless network
Dec 24 14:42:36 volumio sudo[3753]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf
Dec 24 14:42:36 volumio sudo[3753]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:36 volumio sudo[3753]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:36 volumio volumio[1186]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
Dec 24 14:42:36 volumio volumio[1186]: info: Discovery: Restarting Advertising due to device name change
Dec 24 14:42:36 volumio sudo[3756]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service
Dec 24 14:42:36 volumio sudo[3756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:36 volumio systemd[1]: Stopping wireless.service - Wireless Services...
Dec 24 14:42:36 volumio systemd[1]: wireless.service: Deactivated successfully.
Dec 24 14:42:36 volumio systemd[1]: Stopped wireless.service - Wireless Services.
Dec 24 14:42:36 volumio systemd[1]: wireless.service: Consumed 8min 10.703s CPU time.
Dec 24 14:42:36 volumio systemd[1]: Starting wireless.service - Wireless Services...
Dec 24 14:42:37 volumio wireless.js[3762]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless
Dec 24 14:42:37 volumio wireless.js[3762]: WIRELESS.JS: Wired network status changed to: ---connected---
Dec 24 14:42:37 volumio wireless.js[3762]: WIRELESS.JS: Wireless.js initializing wireless flow
Dec 24 14:42:37 volumio wireless.js[3762]: WIRELESS.JS: Cleaning previous...
Dec 24 14:42:37 volumio sudo[3780]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0
Dec 24 14:42:37 volumio sudo[3780]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 24 14:42:37 volumio sudo[3780]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:37 volumio sudo[3783]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down
Dec 24 14:42:37 volumio sudo[3783]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Dec 24 14:42:37 volumio volumio[1186]: info: Discovery: A device disappeared from network
Dec 24 14:42:37 volumio volumio[1186]: info: Discovery: Device volumio disappeared from network
Dec 24 14:42:37 volumio volumio[1186]: info: Discovery: A device disappeared from network
Dec 24 14:42:37 volumio sudo[3783]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:37 volumio sudo[3786]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 24 14:42:37 volumio sudo[3786]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:37 volumio sudo[3786]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:37 volumio wireless.js[3762]: WIRELESS.JS: Stopped aP
Dec 24 14:42:37 volumio sudo[3794]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Dec 24 14:42:37 volumio sudo[3794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:37 volumio sudo[3794]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:37 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Dec 24 14:42:37 volumio sudo[3796]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Dec 24 14:42:37 volumio sudo[3796]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:37 volumio sudo[3796]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:37 volumio sudo[3804]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Dec 24 14:42:37 volumio sudo[3804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:37 volumio sudo[3804]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:37 volumio sudo[3806]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Dec 24 14:42:37 volumio sudo[3806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:38 volumio sudo[3811]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 24 14:42:38 volumio sudo[3811]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:38 volumio sudo[3811]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:39 volumio sudo[3814]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 24 14:42:39 volumio sudo[3814]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:39 volumio sudo[3814]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:40 volumio sudo[3817]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 24 14:42:40 volumio sudo[3817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:40 volumio sudo[3817]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:40 volumio sudo[3806]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:40 volumio wireless.js[3762]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: AR
Dec 24 14:42:40 volumio sudo[3821]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Dec 24 14:42:40 volumio sudo[3821]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:40 volumio sudo[3821]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:40 volumio sudo[3823]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set AR
Dec 24 14:42:40 volumio sudo[3823]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:40 volumio sudo[3823]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:40 volumio wireless.js[3762]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: AR
Dec 24 14:42:40 volumio wireless.js[3762]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow
Dec 24 14:42:40 volumio wireless.js[3762]: WIRELESS.JS: Notified systemd about wireless ready
Dec 24 14:42:40 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Dec 24 14:42:40 volumio systemd[1]: Started wireless.service - Wireless Services.
Dec 24 14:42:40 volumio sudo[3756]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:41 volumio volumio[1186]: info: Discovery: Started advertising with name: Volumio
Dec 24 14:42:41 volumio sudo[3848]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 24 14:42:41 volumio sudo[3848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Dec 24 14:42:41 volumio sudo[3848]: pam_unix(sudo:session): session closed for user root
Dec 24 14:42:42 volumio volumio[1186]: compat.c: read() failed: Resource temporarily unavailable
Dec 24 14:42:42 volumio volumio[1186]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 24 14:42:42 volumio volumio[1186]: Error: dns service error: unknown
Dec 24 14:42:42 volumio volumio[1186]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Dec 24 14:42:42 volumio volumio[1186]: errorCode: -65537
Dec 24 14:42:42 volumio volumio[1186]: }
Dec 24 14:42:42 volumio volumio[1186]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 24 14:42:42 volumio sudo[3865]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-24 14:41'
Dec 24 14:42:42 volumio sudo[3865]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"