May 31 11:27:04 music volumio[1256]: info: Preload queue cleared May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioReplaceandPlayItems May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::ClearQueue May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::stPlaybackTimer May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::updateTrackBlock May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrackBlock May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 1 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::serviceStop May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 1 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::serviceStop May 31 11:27:04 music volumio[1256]: info: ControllerMpd::stop May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::clearPlayQueue May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::saveQueue May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushQueue May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::addQueueItems May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::addQueueItems May 31 11:27:04 music volumio[1256]: info: Preload queue cleared May 31 11:27:04 music volumio[1256]: info: Adding Item to queue: artists://Doechii May 31 11:27:04 music volumio[1256]: info: Exploding uri artists://Doechii in service mpd May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: sendMpdCommand stop took 6 milliseconds May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushQueue May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::saveQueue May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::updateTrackBlock May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrackBlock May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPlay May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::play index 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::play index undefined May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::startPlaybackTimer May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::clearAddPlayTracks NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3 May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 4 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 4 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand stop took 1 milliseconds May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:04 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 4 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand clear took 2 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 2 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 2 milliseconds May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3" May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: 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":"Alive","artist":"Dimension","album":"Organ","uri":"NAS/Quorra.lan/Dimension/Organ (2021)/Dimension - Organ - 02 - Alive.flac","trackType":"flac"} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: No code May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: 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} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: No code May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: 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} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: No code May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: 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} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: No code May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ------------------------------ 26ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 20ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 20ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 20ms May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:04 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:04 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:04 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:04 music volumio[1256]: error: updateQueue error: null May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:04 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:04 music volumio[1256]: info: ------------------------------ 21ms May 31 11:27:04 music volumio[1256]: info: sendMpdCommand add "NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3" took 20 milliseconds May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand play May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:04 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:04 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 15ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 15ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 14ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 13ms May 31 11:27:04 music volumio[1256]: info: sendMpdCommand play took 18 milliseconds May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:04 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:04 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:04 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:04 music volumio[1256]: info: ------------------------------ 3ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 3ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 2ms May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 9 milliseconds May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 8 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 7 milliseconds May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: May 31 11:27:04 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:04 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 11 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 10 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 10 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 10 milliseconds May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 10 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 8 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 9 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 8 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 10 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand status took 9 milliseconds May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"STANKA POOH","artist":"Doechii","album":"Alligator Bites Never Heal","uri":"NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3","trackType":"mp3"} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"STANKA POOH","artist":"Doechii","album":"Alligator Bites Never Heal","uri":"NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3","trackType":"mp3"} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:04 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"STANKA POOH","artist":"Doechii","album":"Alligator Bites Never Heal","uri":"NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3","trackType":"mp3"} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:04 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ------------------------------ 48ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 53ms May 31 11:27:04 music volumio[1256]: info: ------------------------------ 53ms May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 52 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 52 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 52 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 51 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 39 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 39 milliseconds May 31 11:27:04 music volumio[1256]: info: sendMpdCommand playlistinfo took 39 milliseconds May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"STANKA POOH","artist":"Doechii","album":"Alligator Bites Never Heal","uri":"NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3","trackType":"mp3"} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:04 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"STANKA POOH","artist":"Doechii","album":"Alligator Bites Never Heal","uri":"NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3","trackType":"mp3"} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:04 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"STANKA POOH","artist":"Doechii","album":"Alligator Bites Never Heal","uri":"NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3","trackType":"mp3"} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:04 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"STANKA POOH","artist":"Doechii","album":"Alligator Bites Never Heal","uri":"NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3","trackType":"mp3"} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:04 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:04 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"STANKA POOH","artist":"Doechii","album":"Alligator Bites Never Heal","uri":"NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3","trackType":"mp3"} May 31 11:27:04 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:04 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:04 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:04 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:04 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:05 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:05 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:05 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:05 music volumio[1256]: info: ------------------------------ 93ms May 31 11:27:05 music volumio[1256]: info: ------------------------------ 93ms May 31 11:27:05 music volumio[1256]: info: ------------------------------ 85ms May 31 11:27:05 music volumio[1256]: info: ------------------------------ 84ms May 31 11:27:05 music volumio[1256]: info: ------------------------------ 84ms May 31 11:27:05 music volumio[1256]: info: [LastFM] Current track has sufficient metadata: title (1 - STANKA POOH) and artist (Doechii) passed on explicitly May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: warn: FusionDsp - Monitor WebSocket not open, skipping commands May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:05 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:05 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:05 music volumio[1256]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 31 11:27:05 music volumio[1256]: info: FusionDsp - ---- read samplerate from file: 44100 May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:05 music volumio[1256]: error: [LastFM] track info request failed with error: Track not found May 31 11:27:05 music volumio[1256]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 31 11:27:53 music volumio[1256]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 31 11:27:53 music volumio[1256]: info: CURURI: artists://Shygirl May 31 11:27:53 music volumio[1256]: info: Preload queue cleared May 31 11:27:53 music volumio[1256]: info: Preload queue cleared May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 02 - Come for Me.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 03 - Shlut.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 04 - Little Bit.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 05 - Firefly.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 06 - Coochie (a bedtime story).mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 07 - Heaven.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 08 - Nike.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 09 - Poison.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 10 - Honey.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 11 - Missin u.mp3 May 31 11:27:53 music volumio[1256]: info: Preloading song: music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 12 - Wildfire.mp3 May 31 11:27:53 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3 in service mpd May 31 11:27:53 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2001%20-%20Woe.mp3&metadata=false May 31 11:27:53 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3 May 31 11:27:53 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 02 - Come for Me.mp3 in service mpd May 31 11:27:53 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2002%20-%20Come%20for%20Me.mp3&metadata=false May 31 11:27:53 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 02 - Come for Me.mp3 May 31 11:27:53 music volumio[1256]: info: No valid Plugin REST Endpoint May 31 11:27:53 music volumio[1256]: info: No valid Plugin REST Endpoint May 31 11:27:53 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 03 - Shlut.mp3 in service mpd May 31 11:27:53 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2003%20-%20Shlut.mp3&metadata=false May 31 11:27:53 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 03 - Shlut.mp3 May 31 11:27:53 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 04 - Little Bit.mp3 in service mpd May 31 11:27:53 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2004%20-%20Little%20Bit.mp3&metadata=false May 31 11:27:53 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 04 - Little Bit.mp3 May 31 11:27:53 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 05 - Firefly.mp3 in service mpd May 31 11:27:53 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2005%20-%20Firefly.mp3&metadata=false May 31 11:27:53 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 05 - Firefly.mp3 May 31 11:27:53 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 06 - Coochie (a bedtime story).mp3 in service mpd May 31 11:27:53 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2006%20-%20Coochie%20(a%20bedtime%20story).mp3&metadata=false May 31 11:27:53 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 06 - Coochie (a bedtime story).mp3 May 31 11:27:53 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 07 - Heaven.mp3 in service mpd May 31 11:27:53 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2007%20-%20Heaven.mp3&metadata=false May 31 11:27:53 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 07 - Heaven.mp3 May 31 11:27:53 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 08 - Nike.mp3 in service mpd May 31 11:27:53 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2008%20-%20Nike.mp3&metadata=false May 31 11:27:53 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 08 - Nike.mp3 May 31 11:27:53 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 09 - Poison.mp3 in service mpd May 31 11:27:53 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2009%20-%20Poison.mp3&metadata=false May 31 11:27:53 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 09 - Poison.mp3 May 31 11:27:54 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 10 - Honey.mp3 in service mpd May 31 11:27:54 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2010%20-%20Honey.mp3&metadata=false May 31 11:27:54 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 10 - Honey.mp3 May 31 11:27:54 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 11 - Missin u.mp3 in service mpd May 31 11:27:54 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2011%20-%20Missin%20u.mp3&metadata=false May 31 11:27:54 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 11 - Missin u.mp3 May 31 11:27:54 music volumio[1256]: info: Exploding uri music-library/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 12 - Wildfire.mp3 in service mpd May 31 11:27:54 music volumio[1256]: info: ALBUMART /albumart?cacheid=162&web=Shygirl/Nymph/extralarge&path=%2Fmnt%2FNAS%2FQuorra.lan%2FShygirl%2FNymph%20(2022)%2FShygirl%20-%20Nymph%20-%2012%20-%20Wildfire.mp3&metadata=false May 31 11:27:54 music volumio[1256]: info: URI /mnt/NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 12 - Wildfire.mp3 May 31 11:27:56 music tailscaled[855]: magicsock: disco: node [0D9Pd] d:30ac517871a8e0da now using 192.168.3.22:46314 mtu=1360 tx=8378e3d694d4 May 31 11:27:59 music volumio[1256]: info: Preload queue cleared May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioReplaceandPlayItems May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::ClearQueue May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::stPlaybackTimer May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::updateTrackBlock May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrackBlock May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::serviceStop May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::serviceStop May 31 11:27:59 music volumio[1256]: info: ControllerMpd::stop May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::clearPlayQueue May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::saveQueue May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushQueue May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::addQueueItems May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::addQueueItems May 31 11:27:59 music volumio[1256]: info: Preload queue cleared May 31 11:27:59 music volumio[1256]: info: Adding Item to queue: artists://Shygirl May 31 11:27:59 music volumio[1256]: info: Exploding uri artists://Shygirl in service mpd May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: sendMpdCommand stop took 8 milliseconds May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushQueue May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::saveQueue May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::updateTrackBlock May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrackBlock May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPlay May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::play index 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::play index undefined May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::startPlaybackTimer May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::clearAddPlayTracks NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3 May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 7 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 7 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand stop took 4 milliseconds May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:59 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand clear took 2 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 2 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3" May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: 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":"STANKA POOH","artist":"Doechii","album":"Alligator Bites Never Heal","uri":"NAS/Quorra.lan/Doechii/Alligator Bites Never Heal (2024)/Doechii - Alligator Bites Never Heal - 01 - STANKA POOH.mp3","trackType":"mp3"} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: No code May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: 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} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: No code May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: 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} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: No code May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: 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} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: No code May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ------------------------------ 25ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 17ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 17ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 16ms May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:59 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:59 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:59 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:59 music volumio[1256]: error: updateQueue error: null May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:59 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:59 music volumio[1256]: info: ------------------------------ 19ms May 31 11:27:59 music volumio[1256]: info: sendMpdCommand add "NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3" took 18 milliseconds May 31 11:27:59 music volumio[1256]: info: ------------------------------ 2ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 2ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 2ms May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand play May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:59 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:59 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:27:59 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 14ms May 31 11:27:59 music volumio[1256]: info: sendMpdCommand play took 14 milliseconds May 31 11:27:59 music volumio[1256]: info: ------------------------------ 14ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 13ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 13ms May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 4 milliseconds May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 5 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 4 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 4 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 4 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 1 milliseconds May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Woe","artist":"Shygirl","album":"Nymph","uri":"NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3","trackType":"mp3"} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:27:59 music volumio[1256]: info: ------------------------------ 6ms May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: May 31 11:27:59 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:27:59 music volumio[1256]: info: ControllerMpd::getState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 3 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 2 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Woe","artist":"Shygirl","album":"Nymph","uri":"NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3","trackType":"mp3"} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:59 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Woe","artist":"Shygirl","album":"Nymph","uri":"NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3","trackType":"mp3"} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:59 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Woe","artist":"Shygirl","album":"Nymph","uri":"NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3","trackType":"mp3"} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:59 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ------------------------------ 31ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 31ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 31ms May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 25 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 25 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 25 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 25 milliseconds May 31 11:27:59 music volumio[1256]: info: sendMpdCommand playlistinfo took 25 milliseconds May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Woe","artist":"Shygirl","album":"Nymph","uri":"NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3","trackType":"mp3"} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:59 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Woe","artist":"Shygirl","album":"Nymph","uri":"NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3","trackType":"mp3"} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:59 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Woe","artist":"Shygirl","album":"Nymph","uri":"NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3","trackType":"mp3"} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:59 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ControllerMpd::pushState May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: verbose: STATE SERVICE {"status":"play","position":0,"seek":958,"duration":220,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Woe","artist":"Shygirl","album":"Nymph","uri":"NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3","trackType":"mp3"} May 31 11:27:59 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState stateService play May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::syncState currentStatus play May 31 11:27:59 music volumio[1256]: info: Received an update from plugin. extracting info from payload May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:27:59 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:27:59 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:27:59 music volumio[1256]: info: ------------------------------ 56ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 55ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 55ms May 31 11:27:59 music volumio[1256]: info: ------------------------------ 55ms May 31 11:27:59 music volumio[1256]: info: [LastFM] Current track has sufficient metadata: title (1 - Woe) and artist (Shygirl) passed on explicitly May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: warn: FusionDsp - Monitor WebSocket not open, skipping commands May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: FusionDsp - Volumio is playing May 31 11:27:59 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: Display-configuration --- Volumio status=play timeout=120 noifplay=true screensavertype=dpms May 31 11:27:59 music volumio[1256]: info: Display-configuration --- → Wakeup triggered May 31 11:27:59 music volumio[1256]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 May 31 11:27:59 music volumio[1256]: info: FusionDsp - ---- read samplerate from file: 44100 May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: Display-configuration --- wakeupScreen: DPMS - screen on May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: info: FusionDsp - Clipping Monitor started May 31 11:27:59 music volumio[1256]: error: [LastFM] track info request failed with error: Track not found May 31 11:27:59 music volumio[1256]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 31 11:28:00 music volumio[1256]: info: Preload queue cleared May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioReplaceandPlayItems May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::ClearQueue May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::stop May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::stPlaybackTimer May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::updateTrackBlock May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrackBlock May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::serviceStop May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::serviceStop May 31 11:28:00 music volumio[1256]: info: ControllerMpd::stop May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::clearPlayQueue May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::saveQueue May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushQueue May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::addQueueItems May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::addQueueItems May 31 11:28:00 music volumio[1256]: info: Preload queue cleared May 31 11:28:00 music volumio[1256]: info: Adding Item to queue: artists://Shygirl May 31 11:28:00 music volumio[1256]: info: Using cached record of: artists://Shygirl May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushQueue May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::saveQueue May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::updateTrackBlock May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrackBlock May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPlay May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::play index 0 May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::stop May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::play index undefined May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::startPlaybackTimer May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::clearAddPlayTracks NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3 May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand stop May 31 11:28:00 music volumio[1256]: info: FusionDsp - Volumio is not playing May 31 11:28:00 music volumio[1256]: info: FusionDsp - Clipped samples monitor stopped May 31 11:28:00 music volumio[1256]: info: FusionDsp - volume level for loudness 50 gain applied 0 May 31 11:28:00 music volumio[1256]: info: Display-configuration --- Volumio status=stop timeout=120 noifplay=true screensavertype=dpms May 31 11:28:00 music volumio[1256]: info: ControllerMpd::getState May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:28:00 music volumio[1256]: info: May 31 11:28:00 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:28:00 music volumio[1256]: info: sendMpdCommand stop took 7 milliseconds May 31 11:28:00 music volumio[1256]: info: ControllerMpd::getState May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:28:00 music volumio[1256]: info: sendMpdCommand stop took 3 milliseconds May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand clear May 31 11:28:00 music volumio[1256]: info: May 31 11:28:00 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:28:00 music volumio[1256]: info: ControllerMpd::getState May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:28:00 music volumio[1256]: info: May 31 11:28:00 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:28:00 music volumio[1256]: info: ControllerMpd::getState May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:28:00 music volumio[1256]: info: May 31 11:28:00 music volumio[1256]: ---------------------------- MPD announces state update: player May 31 11:28:00 music volumio[1256]: info: ControllerMpd::getState May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand status May 31 11:28:00 music volumio[1256]: info: May 31 11:28:00 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:28:00 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:28:00 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:28:00 music volumio[1256]: info: sendMpdCommand status took 2 milliseconds May 31 11:28:00 music volumio[1256]: info: sendMpdCommand clear took 2 milliseconds May 31 11:28:00 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:28:00 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:28:00 music volumio[1256]: info: sendMpdCommand status took 1 milliseconds May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand add "NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3" May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::parseState May 31 11:28:00 music volumio[1256]: info: ControllerMpd::pushState May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: 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} May 31 11:28:00 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: No code May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: ControllerMpd::pushState May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: 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} May 31 11:28:00 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: No code May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: ControllerMpd::pushState May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::servicePushState May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: 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} May 31 11:28:00 music volumio[1256]: verbose: CURRENT POSITION 0 May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::syncState stateService stop May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::syncState currentStatus stop May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: No code May 31 11:28:00 music volumio[1256]: info: CoreStateMachine::pushState May 31 11:28:00 music volumio[1256]: info: CorePlayQueue::getTrack 0 May 31 11:28:00 music volumio[1256]: info: CoreCommandRouter::volumioPushState May 31 11:28:00 music volumio[1256]: info: ------------------------------ 11ms May 31 11:28:00 music volumio[1256]: info: ------------------------------ 11ms May 31 11:28:00 music volumio[1256]: info: ------------------------------ 11ms May 31 11:28:00 music volumio[1256]: info: May 31 11:28:00 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:28:00 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:28:00 music volumio[1256]: info: May 31 11:28:00 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:28:00 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:28:00 music volumio[1256]: info: May 31 11:28:00 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:28:00 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:28:00 music volumio[1256]: error: updateQueue error: null May 31 11:28:00 music volumio[1256]: info: May 31 11:28:00 music volumio[1256]: ---------------------------- MPD announces system playlist update May 31 11:28:00 music volumio[1256]: info: Ignoring MPD Status Update May 31 11:28:00 music volumio[1256]: info: ------------------------------ 13ms May 31 11:28:00 music volumio[1256]: info: sendMpdCommand playlistinfo took 12 milliseconds May 31 11:28:00 music volumio[1256]: info: sendMpdCommand playlistinfo took 12 milliseconds May 31 11:28:00 music volumio[1256]: info: sendMpdCommand add "NAS/Quorra.lan/Shygirl/Nymph (2022)/Shygirl - Nymph - 01 - Woe.mp3" took 12 milliseconds May 31 11:28:00 music volumio[1256]: info: ------------------------------ 2ms May 31 11:28:00 music volumio[1256]: info: ------------------------------ 1ms May 31 11:28:00 music volumio[1256]: info: ------------------------------ 1ms May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::parseTrackInfo May 31 11:28:00 music volumio[1256]: verbose: ControllerMpd::sendMpdCommand play May 31 11:28:00 music volumio[1256]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') May 31 11:28:00 music volumio[1256]: info: ------------------------------ 15ms May 31 11:28:00 music volumio[1256]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 11:28:00 music volumio[1256]: TypeError: Cannot read properties of undefined (reading 'split') May 31 11:28:00 music volumio[1256]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:280:60) May 31 11:28:00 music volumio[1256]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 31 11:28:00 music volumio[1256]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) May 31 11:28:00 music volumio[1256]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 11:28:00 music sudo[13072]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-31 11:27' May 31 11:28:00 music sudo[13072]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"