-- Logs begin at Tue 2024-10-01 18:18:44 -03, end at Tue 2024-10-01 21:22:54 -03. -- Oct 01 21:21:13 volumio ntpd[1591]: Soliciting pool server 2606:4700:f1::1 Oct 01 21:21:17 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 01 21:21:17 volumio volumio[1066]: info: CURURI: artists://Sting/The%20Dream%20Of%20The%20Blue%20Turtles Oct 01 21:21:17 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/03. Sting - Russians.flac Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/04. Sting - Children's Crusade.flac Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/05. Sting - Shadows In The Rain.flac Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/06. Sting - We Work The Black Seam.flac Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/07. Sting - Consider Me Gone.flac Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/08. Sting - The Dream Of The Blue Turtles.flac Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/09. Sting - Moon Over Bourbon Street.flac Oct 01 21:21:17 volumio volumio[1066]: info: Preloading song: music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/10. Sting - Fortress Around Your Heart (Album Version).flac Oct 01 21:21:17 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac in service mpd Oct 01 21:21:17 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F01.%20Sting%20-%20If%20You%20Love%20Somebody%20Set%20Them%20Free%20(Edit).flac&metadata=false Oct 01 21:21:17 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac Oct 01 21:21:17 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac in service mpd Oct 01 21:21:17 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F02.%20Sting%20-%20Love%20Is%20The%20Seventh%20Wave.flac&metadata=false Oct 01 21:21:17 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac Oct 01 21:21:17 volumio volumio[1066]: info: No valid Plugin REST Endpoint Oct 01 21:21:17 volumio volumio[1066]: info: No valid Plugin REST Endpoint Oct 01 21:21:17 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/03. Sting - Russians.flac in service mpd Oct 01 21:21:17 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F03.%20Sting%20-%20Russians.flac&metadata=false Oct 01 21:21:17 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/03. Sting - Russians.flac Oct 01 21:21:17 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/04. Sting - Children's Crusade.flac in service mpd Oct 01 21:21:17 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F04.%20Sting%20-%20Children's%20Crusade.flac&metadata=false Oct 01 21:21:17 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/04. Sting - Children's Crusade.flac Oct 01 21:21:17 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/05. Sting - Shadows In The Rain.flac in service mpd Oct 01 21:21:17 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F05.%20Sting%20-%20Shadows%20In%20The%20Rain.flac&metadata=false Oct 01 21:21:17 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/05. Sting - Shadows In The Rain.flac Oct 01 21:21:17 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/06. Sting - We Work The Black Seam.flac in service mpd Oct 01 21:21:17 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F06.%20Sting%20-%20We%20Work%20The%20Black%20Seam.flac&metadata=false Oct 01 21:21:17 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/06. Sting - We Work The Black Seam.flac Oct 01 21:21:18 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/07. Sting - Consider Me Gone.flac in service mpd Oct 01 21:21:18 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F07.%20Sting%20-%20Consider%20Me%20Gone.flac&metadata=false Oct 01 21:21:18 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/07. Sting - Consider Me Gone.flac Oct 01 21:21:18 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/08. Sting - The Dream Of The Blue Turtles.flac in service mpd Oct 01 21:21:18 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F08.%20Sting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles.flac&metadata=false Oct 01 21:21:18 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/08. Sting - The Dream Of The Blue Turtles.flac Oct 01 21:21:18 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/09. Sting - Moon Over Bourbon Street.flac in service mpd Oct 01 21:21:18 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F09.%20Sting%20-%20Moon%20Over%20Bourbon%20Street.flac&metadata=false Oct 01 21:21:18 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/09. Sting - Moon Over Bourbon Street.flac Oct 01 21:21:18 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/10. Sting - Fortress Around Your Heart (Album Version).flac in service mpd Oct 01 21:21:18 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=Sting/The%20Dream%20Of%20The%20Blue%20Turtles/extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FQobuz%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1985)%20%5BFLAC%5D%20%5B16B-44.1kHz%5D%2F10.%20Sting%20-%20Fortress%20Around%20Your%20Heart%20(Album%20Version).flac&metadata=false Oct 01 21:21:18 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/10. Sting - Fortress Around Your Heart (Album Version).flac Oct 01 21:21:23 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:21:23 volumio volumio[1066]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::ClearQueue Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::stop Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:23 volumio volumio[1066]: info: CorePlayQueue::clearPlayQueue Oct 01 21:21:23 volumio volumio[1066]: info: CorePlayQueue::saveQueue Oct 01 21:21:23 volumio volumio[1066]: info: CoreCommandRouter::volumioPushQueue Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::addQueueItems Oct 01 21:21:23 volumio volumio[1066]: info: CorePlayQueue::addQueueItems Oct 01 21:21:23 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:21:23 volumio volumio[1066]: info: Adding Item to queue: artists://Sting/The%20Dream%20Of%20The%20Blue%20Turtles Oct 01 21:21:23 volumio volumio[1066]: info: Exploding uri artists://Sting/The%20Dream%20Of%20The%20Blue%20Turtles in service mpd Oct 01 21:21:23 volumio volumio[1066]: info: CoreCommandRouter::volumioPushQueue Oct 01 21:21:23 volumio volumio[1066]: info: CorePlayQueue::saveQueue Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::updateTrackBlock Oct 01 21:21:23 volumio volumio[1066]: info: CorePlayQueue::getTrackBlock Oct 01 21:21:23 volumio volumio[1066]: info: CoreCommandRouter::volumioPlay Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::play index 0 Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::stop Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::play index undefined Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:23 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:23 volumio volumio[1066]: info: CoreStateMachine::startPlaybackTimer Oct 01 21:21:23 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:23 volumio volumio[1066]: verbose: ControllerMpd::clearAddPlayTracks USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac Oct 01 21:21:23 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 21:21:23 volumio volumio[1066]: info: sendMpdCommand stop took 0 milliseconds Oct 01 21:21:23 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand clear Oct 01 21:21:23 volumio volumio[1066]: info: sendMpdCommand clear took 0 milliseconds Oct 01 21:21:23 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand add "USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac" Oct 01 21:21:23 volumio volumio[1066]: info: Oct 01 21:21:23 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:23 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:23 volumio volumio[1066]: info: Oct 01 21:21:23 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:23 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:23 volumio volumio[1066]: info: Oct 01 21:21:23 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:23 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:23 volumio volumio[1066]: info: sendMpdCommand add "USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac" took 1 milliseconds Oct 01 21:21:23 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand play Oct 01 21:21:23 volumio volumio[1066]: info: ------------------------------ 1ms Oct 01 21:21:23 volumio volumio[1066]: info: ------------------------------ 1ms Oct 01 21:21:23 volumio volumio[1066]: info: ------------------------------ 1ms Oct 01 21:21:23 volumio volumio[1066]: info: Oct 01 21:21:23 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:23 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:23 volumio volumio[1066]: info: sendMpdCommand play took 1 milliseconds Oct 01 21:21:23 volumio volumio[1066]: error: Upnp client error: Error: This socket has been ended by the other party Oct 01 21:21:23 volumio volumio[1066]: info: ------------------------------ 1ms Oct 01 21:21:24 volumio volumio[1066]: info: Oct 01 21:21:24 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:24 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:24 volumio volumio[1066]: info: Oct 01 21:21:24 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:24 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:24 volumio volumio[1066]: info: Oct 01 21:21:24 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:24 volumio volumio[1066]: info: sendMpdCommand status took 118 milliseconds Oct 01 21:21:24 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:24 volumio volumio[1066]: info: sendMpdCommand status took 117 milliseconds Oct 01 21:21:24 volumio volumio[1066]: info: sendMpdCommand status took 0 milliseconds Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:24 volumio volumio[1066]: info: Oct 01 21:21:24 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:24 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:24 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 21:21:24 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 01 21:21:24 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:24 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"896 Kbps","isStreaming":false,"title":"If You Love Somebody Set Them Free (Edit)","artist":"Sting","album":"The Dream Of The Blue Turtles","uri":"USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac","trackType":"flac"} Oct 01 21:21:24 volumio volumio[1066]: verbose: CURRENT POSITION 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus stop Oct 01 21:21:24 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":455,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"985 Kbps","isStreaming":false,"title":"If You Love Somebody Set Them Free (Edit)","artist":"Sting","album":"The Dream Of The Blue Turtles","uri":"USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac","trackType":"flac"} Oct 01 21:21:24 volumio volumio[1066]: verbose: CURRENT POSITION 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus play Oct 01 21:21:24 volumio volumio[1066]: info: Received an update from plugin. extracting info from payload Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:24 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"If You Love Somebody Set Them Free (Edit)","artist":"Sting","album":"The Dream Of The Blue Turtles","uri":"USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac","trackType":"flac"} Oct 01 21:21:24 volumio volumio[1066]: verbose: CURRENT POSITION 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus play Oct 01 21:21:24 volumio volumio[1066]: info: Received an update from plugin. extracting info from payload Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:24 volumio volumio[1066]: info: ------------------------------ 122ms Oct 01 21:21:24 volumio volumio[1066]: info: ------------------------------ 125ms Oct 01 21:21:24 volumio volumio[1066]: info: ------------------------------ 9ms Oct 01 21:21:24 volumio volumio[1066]: info: sendMpdCommand status took 7 milliseconds Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:24 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 01 21:21:24 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:24 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":256,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"If You Love Somebody Set Them Free (Edit)","artist":"Sting","album":"The Dream Of The Blue Turtles","uri":"USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac","trackType":"flac"} Oct 01 21:21:24 volumio volumio[1066]: verbose: CURRENT POSITION 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus play Oct 01 21:21:24 volumio volumio[1066]: info: Received an update from plugin. extracting info from payload Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:24 volumio volumio[1066]: info: ------------------------------ 16ms Oct 01 21:21:24 volumio thd[785]: Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:24 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:24 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:24 volumio volumio[1066]: info: Oct 01 21:21:24 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:24 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:24 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:24 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:24 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:24 volumio thd[785]: [158B blob data] Oct 01 21:21:25 volumio thd[785]: {"time":1727828484767,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:25 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:25 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:25 volumio volumio[1066]: info: Oct 01 21:21:25 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:25 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:25 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:25 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:25 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:25 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:25 volumio thd[785]: [158B blob data] Oct 01 21:21:26 volumio thd[785]: {"time":1727828485366,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:26 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:26 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:26 volumio volumio[1066]: info: Oct 01 21:21:26 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:26 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:26 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:26 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:26 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:26 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:26 volumio thd[785]: [158B blob data] Oct 01 21:21:26 volumio thd[785]: {"time":1727828486212,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:26 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:26 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:26 volumio volumio[1066]: info: Oct 01 21:21:26 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:26 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:26 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:26 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:26 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:26 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:26 volumio thd[785]: [158B blob data] Oct 01 21:21:27 volumio thd[785]: {"time":1727828486932,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:27 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:27 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:27 volumio volumio[1066]: info: Oct 01 21:21:27 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:27 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:27 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:27 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:27 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:27 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:27 volumio thd[785]: [158B blob data] Oct 01 21:21:27 volumio thd[785]: {"time":1727828487222,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:27 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:27 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:27 volumio volumio[1066]: info: Oct 01 21:21:27 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:27 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:27 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:27 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:27 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:27 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:27 volumio thd[785]: [158B blob data] Oct 01 21:21:27 volumio thd[785]: {"time":1727828487464,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Oct 01 21:21:27 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:27 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:27 volumio volumio[1066]: info: Oct 01 21:21:27 volumio volumio[1066]: ---------------------------- Client requests Volume + Oct 01 21:21:27 volumio volumio[1066]: info: VolumeController::SetAlsaVolume+ Oct 01 21:21:27 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:27 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:27 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:27 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:27 volumio thd[785]: [158B blob data] Oct 01 21:21:29 volumio thd[785]: {"time":1727828487808,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Oct 01 21:21:29 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:29 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:29 volumio volumio[1066]: info: Oct 01 21:21:29 volumio volumio[1066]: ---------------------------- Client requests Volume + Oct 01 21:21:29 volumio volumio[1066]: info: VolumeController::SetAlsaVolume+ Oct 01 21:21:29 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:29 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:29 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:29 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:29 volumio thd[785]: [158B blob data] Oct 01 21:21:34 volumio thd[785]: {"time":1727828489053,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio next Oct 01 21:21:34 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:34 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- Client requests Volumio next Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioNext Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::next Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::stop Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::stPlaybackTimer Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::updateTrackBlock Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrackBlock Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::serviceStop Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::serviceStop Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::stop Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 21:21:34 volumio thd[785]: [158B blob data] Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand stop took 67 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::play index undefined Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::startPlaybackTimer Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::clearAddPlayTracks USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::updateTrackBlock Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrackBlock Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand status took 1 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand stop took 1 milliseconds Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand clear Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:34 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand status took 0 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand clear took 0 milliseconds Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand add "USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac" Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: 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":"If You Love Somebody Set Them Free (Edit)","artist":"Sting","album":"The Dream Of The Blue Turtles","uri":"USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/01. Sting - If You Love Somebody Set Them Free (Edit).flac","trackType":"flac"} Oct 01 21:21:34 volumio volumio[1066]: verbose: CURRENT POSITION 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState stateService stop Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus stop Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: No code Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 7ms Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:34 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:34 volumio volumio[1066]: error: updateQueue error: null Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:34 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 6ms Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand add "USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac" took 5 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 1ms Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand play Oct 01 21:21:34 volumio volumio[1066]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 7ms Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:34 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 2ms Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand play took 1 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 1ms Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand status took 114 milliseconds Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand status took 115 milliseconds Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:34 volumio volumio[1066]: info: Oct 01 21:21:34 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand status took 1 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"633 Kbps","isStreaming":false,"title":"Love Is The Seventh Wave","artist":"Sting","album":"The Dream Of The Blue Turtles","uri":"USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac","trackType":"flac"} Oct 01 21:21:34 volumio volumio[1066]: verbose: CURRENT POSITION 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus stop Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"855 Kbps","isStreaming":false,"title":"Love Is The Seventh Wave","artist":"Sting","album":"The Dream Of The Blue Turtles","uri":"USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac","trackType":"flac"} Oct 01 21:21:34 volumio volumio[1066]: verbose: CURRENT POSITION 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus play Oct 01 21:21:34 volumio volumio[1066]: info: Received an update from plugin. extracting info from payload Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 118ms Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 119ms Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand status took 4 milliseconds Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"855 Kbps","isStreaming":false,"title":"Love Is The Seventh Wave","artist":"Sting","album":"The Dream Of The Blue Turtles","uri":"USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac","trackType":"flac"} Oct 01 21:21:34 volumio volumio[1066]: verbose: CURRENT POSITION 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus play Oct 01 21:21:34 volumio volumio[1066]: info: Received an update from plugin. extracting info from payload Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 7ms Oct 01 21:21:34 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 01 21:21:34 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:34 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"855 Kbps","isStreaming":false,"title":"Love Is The Seventh Wave","artist":"Sting","album":"The Dream Of The Blue Turtles","uri":"USB/WD/Musica/Qobuz/Sting - The Dream Of The Blue Turtles (1985) [FLAC] [16B-44.1kHz]/02. Sting - Love Is The Seventh Wave.flac","trackType":"flac"} Oct 01 21:21:34 volumio volumio[1066]: verbose: CURRENT POSITION 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus play Oct 01 21:21:34 volumio volumio[1066]: info: Received an update from plugin. extracting info from payload Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:34 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:34 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:34 volumio volumio[1066]: info: ------------------------------ 12ms Oct 01 21:21:46 volumio thd[785]: {"time":1727828494554,"response":"next Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:46 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:46 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:46 volumio volumio[1066]: info: Oct 01 21:21:46 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:46 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:46 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:46 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:46 volumio thd[785]: [158B blob data] Oct 01 21:21:46 volumio thd[785]: {"time":1727828506097,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:46 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:46 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:46 volumio volumio[1066]: info: Oct 01 21:21:46 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:46 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:46 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:46 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:46 volumio thd[785]: [158B blob data] Oct 01 21:21:46 volumio thd[785]: {"time":1727828506392,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:46 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:46 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:46 volumio volumio[1066]: info: Oct 01 21:21:46 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:46 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:46 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:46 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:46 volumio thd[785]: [158B blob data] Oct 01 21:21:46 volumio thd[785]: {"time":1727828506526,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:46 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:46 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:46 volumio volumio[1066]: info: Oct 01 21:21:46 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:46 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:46 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:46 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:46 volumio thd[785]: [158B blob data] Oct 01 21:21:46 volumio thd[785]: {"time":1727828506714,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:21:46 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:46 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:46 volumio volumio[1066]: info: Oct 01 21:21:46 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:21:46 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:21:46 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:46 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:46 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:46 volumio thd[785]: [158B blob data] Oct 01 21:21:54 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::ClearQueue Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::stop Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::stPlaybackTimer Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::updateTrackBlock Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrackBlock Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::serviceStop Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 1 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::serviceStop Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::stop Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::clearPlayQueue Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::saveQueue Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushQueue Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::addQueueItems Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::addQueueItems Oct 01 21:21:54 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:21:54 volumio volumio[1066]: info: Adding Item to queue: artists://Sting/...Nothing%20Like%20The%20Sun Oct 01 21:21:54 volumio volumio[1066]: info: Exploding uri artists://Sting/...Nothing%20Like%20The%20Sun in service mpd Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushQueue Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::saveQueue Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::updateTrackBlock Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrackBlock Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPlay Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::play index 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::stop Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::play index undefined Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::startPlaybackTimer Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::clearAddPlayTracks USB/WD/Musica/Qobuz/Sting - ...Nothing Like The Sun (1987) [FLAC] [16B-44.1kHz]/01. Sting - The Lazarus Heart.flac Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand stop took 74 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand stop took 68 milliseconds Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand clear Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:54 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand status took 1 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand clear took 0 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand status took 0 milliseconds Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand add "USB/WD/Musica/Qobuz/Sting - ...Nothing Like The Sun (1987) [FLAC] [16B-44.1kHz]/01. Sting - The Lazarus Heart.flac" Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: 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} Oct 01 21:21:54 volumio volumio[1066]: verbose: CURRENT POSITION 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState stateService stop Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus stop Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: No code Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: ------------------------------ 4ms Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:54 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:54 volumio volumio[1066]: error: updateQueue error: null Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:54 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:54 volumio volumio[1066]: info: ------------------------------ 4ms Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand add "USB/WD/Musica/Qobuz/Sting - ...Nothing Like The Sun (1987) [FLAC] [16B-44.1kHz]/01. Sting - The Lazarus Heart.flac" took 5 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: ------------------------------ 1ms Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand play Oct 01 21:21:54 volumio volumio[1066]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 01 21:21:54 volumio volumio[1066]: info: ------------------------------ 6ms Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces system playlist update Oct 01 21:21:54 volumio volumio[1066]: info: Ignoring MPD Status Update Oct 01 21:21:54 volumio volumio[1066]: info: ------------------------------ 2ms Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand play took 1 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: ------------------------------ 1ms Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand status took 109 milliseconds Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand status took 110 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"275 Kbps","isStreaming":false,"title":"The Lazarus Heart","artist":"Sting","album":"...Nothing Like The Sun","uri":"USB/WD/Musica/Qobuz/Sting - ...Nothing Like The Sun (1987) [FLAC] [16B-44.1kHz]/01. Sting - The Lazarus Heart.flac","trackType":"flac"} Oct 01 21:21:54 volumio volumio[1066]: verbose: CURRENT POSITION 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus stop Oct 01 21:21:54 volumio volumio[1066]: info: ------------------------------ 112ms Oct 01 21:21:54 volumio volumio[1066]: info: Oct 01 21:21:54 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand status took 1 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand status took 0 milliseconds Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseState Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":774,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"432 Kbps","isStreaming":false,"title":"The Lazarus Heart","artist":"Sting","album":"...Nothing Like The Sun","uri":"USB/WD/Musica/Qobuz/Sting - ...Nothing Like The Sun (1987) [FLAC] [16B-44.1kHz]/01. Sting - The Lazarus Heart.flac","trackType":"flac"} Oct 01 21:21:54 volumio volumio[1066]: verbose: CURRENT POSITION 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus play Oct 01 21:21:54 volumio volumio[1066]: info: Received an update from plugin. extracting info from payload Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: ------------------------------ 114ms Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 01 21:21:54 volumio volumio[1066]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:54 volumio volumio[1066]: verbose: ControllerMpd::parseTrackInfo Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"445 Kbps","isStreaming":false,"title":"The Lazarus Heart","artist":"Sting","album":"...Nothing Like The Sun","uri":"USB/WD/Musica/Qobuz/Sting - ...Nothing Like The Sun (1987) [FLAC] [16B-44.1kHz]/01. Sting - The Lazarus Heart.flac","trackType":"flac"} Oct 01 21:21:54 volumio volumio[1066]: verbose: CURRENT POSITION 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus play Oct 01 21:21:54 volumio volumio[1066]: info: Received an update from plugin. extracting info from payload Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: ControllerMpd::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::servicePushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":276,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"445 Kbps","isStreaming":false,"title":"The Lazarus Heart","artist":"Sting","album":"...Nothing Like The Sun","uri":"USB/WD/Musica/Qobuz/Sting - ...Nothing Like The Sun (1987) [FLAC] [16B-44.1kHz]/01. Sting - The Lazarus Heart.flac","trackType":"flac"} Oct 01 21:21:54 volumio volumio[1066]: verbose: CURRENT POSITION 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState stateService play Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::syncState currentStatus play Oct 01 21:21:54 volumio volumio[1066]: info: Received an update from plugin. extracting info from payload Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:54 volumio volumio[1066]: info: ------------------------------ 10ms Oct 01 21:21:56 volumio thd[785]: {"time":1727828506924,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume plus Oct 01 21:21:56 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:21:56 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:21:56 volumio volumio[1066]: info: Oct 01 21:21:56 volumio volumio[1066]: ---------------------------- Client requests Volume + Oct 01 21:21:56 volumio volumio[1066]: info: VolumeController::SetAlsaVolume+ Oct 01 21:21:56 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:21:56 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:21:56 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:21:56 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:21:56 volumio thd[785]: [158B blob data] Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 21:22:15 volumio volumio[1066]: info: Retrieving Cloud Streaming UI Oct 01 21:22:15 volumio volumio[1066]: info: Getting Tidal Cloud Configuration Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 21:22:15 volumio volumio[1066]: info: Getting Qobuz Cloud Configuration Oct 01 21:22:15 volumio volumio[1066]: info: Asking plugin for UI Config Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 21:22:15 volumio volumio[1066]: info: Getting Spotify Cloud Configuration Oct 01 21:22:15 volumio volumio[1066]: info: Asking plugin for UI Config Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 21:22:15 volumio volumio[1066]: info: Saving Spotify Acccount Oct 01 21:22:15 volumio volumio[1066]: info: Got Tidal Cloud Configuration Oct 01 21:22:15 volumio volumio[1066]: info: Got it Oct 01 21:22:15 volumio volumio[1066]: info: Got it Oct 01 21:22:15 volumio volumio[1066]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 01 21:22:15 volumio volumio[1066]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::volumioGetBrowseSources Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::volumioGetBrowseSources Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::volumioGetBrowseSources Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 01 21:22:15 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 01 21:22:18 volumio ntpd[1591]: Soliciting pool server 2606:4700:f1::123 Oct 01 21:22:19 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 01 21:22:23 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 01 21:22:38 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 01 21:22:38 volumio volumio[1066]: info: CURURI: music-library Oct 01 21:22:38 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:22:40 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 01 21:22:40 volumio volumio[1066]: info: CURURI: music-library/USB Oct 01 21:22:40 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:22:42 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 01 21:22:42 volumio volumio[1066]: info: CURURI: music-library/USB/WD Oct 01 21:22:42 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:22:44 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 01 21:22:44 volumio volumio[1066]: info: CURURI: music-library/USB/WD/Musica Oct 01 21:22:44 volumio thd[785]: {"time":1727828516760,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:22:44 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:22:44 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:22:44 volumio volumio[1066]: info: Oct 01 21:22:44 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:22:44 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:22:44 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:22:44 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:22:44 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:22:44 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:22:44 volumio thd[785]: [158B blob data] Oct 01 21:22:44 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:22:45 volumio thd[785]: {"time":1727828564696,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:22:45 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:22:45 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:22:45 volumio volumio[1066]: info: Oct 01 21:22:45 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:22:45 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:22:45 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:22:45 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:22:45 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:22:45 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:22:45 volumio thd[785]: [158B blob data] Oct 01 21:22:45 volumio thd[785]: {"time":1727828565526,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:22:45 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:22:45 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:22:45 volumio volumio[1066]: info: Oct 01 21:22:45 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:22:45 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:22:45 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:22:45 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:22:45 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:22:45 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:22:45 volumio thd[785]: [158B blob data] Oct 01 21:22:46 volumio thd[785]: {"time":1727828565766,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:22:46 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:22:46 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:22:46 volumio volumio[1066]: info: Oct 01 21:22:46 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:22:46 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:22:46 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:22:46 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:22:46 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:22:46 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:22:46 volumio thd[785]: [158B blob data] Oct 01 21:22:46 volumio thd[785]: {"time":1727828566120,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:22:46 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:22:46 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:22:46 volumio volumio[1066]: info: Oct 01 21:22:46 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:22:46 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:22:46 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:22:46 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:22:46 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:22:46 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:22:46 volumio thd[785]: [158B blob data] Oct 01 21:22:47 volumio thd[785]: {"time":1727828566326,"response":"volume Success"}Executing trigger action: /usr/local/bin/volumio volume minus Oct 01 21:22:47 volumio thd[785]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 01 21:22:47 volumio thd[785]: Dload Upload Total Spent Left Speed Oct 01 21:22:47 volumio volumio[1066]: info: Oct 01 21:22:47 volumio volumio[1066]: ---------------------------- Client requests Volume - Oct 01 21:22:47 volumio volumio[1066]: info: VolumeController::SetAlsaVolume- Oct 01 21:22:47 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:22:47 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:22:47 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:22:47 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:22:47 volumio thd[785]: [158B blob data] Oct 01 21:22:51 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 01 21:22:51 volumio volumio[1066]: info: CURURI: music-library/USB/WD/Musica/Wav Oct 01 21:22:51 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:22:54 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:22:54 volumio volumio[1066]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 01 21:22:54 volumio volumio[1066]: info: CoreStateMachine::ClearQueue Oct 01 21:22:54 volumio volumio[1066]: info: CoreStateMachine::stop Oct 01 21:22:54 volumio volumio[1066]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 01 21:22:54 volumio volumio[1066]: info: CoreStateMachine::stPlaybackTimer Oct 01 21:22:54 volumio volumio[1066]: info: CoreStateMachine::updateTrackBlock Oct 01 21:22:54 volumio volumio[1066]: info: CorePlayQueue::getTrackBlock Oct 01 21:22:54 volumio volumio[1066]: info: CoreStateMachine::pushState Oct 01 21:22:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:22:54 volumio volumio[1066]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 01 21:22:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushState Oct 01 21:22:54 volumio volumio[1066]: info: CoreStateMachine::serviceStop Oct 01 21:22:54 volumio volumio[1066]: info: CorePlayQueue::getTrack 0 Oct 01 21:22:54 volumio volumio[1066]: info: CoreCommandRouter::serviceStop Oct 01 21:22:54 volumio volumio[1066]: info: ControllerMpd::stop Oct 01 21:22:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand stop Oct 01 21:22:54 volumio volumio[1066]: info: CorePlayQueue::clearPlayQueue Oct 01 21:22:54 volumio volumio[1066]: info: CorePlayQueue::saveQueue Oct 01 21:22:54 volumio volumio[1066]: info: CoreCommandRouter::volumioPushQueue Oct 01 21:22:54 volumio volumio[1066]: info: CoreStateMachine::addQueueItems Oct 01 21:22:54 volumio volumio[1066]: info: CorePlayQueue::addQueueItems Oct 01 21:22:54 volumio volumio[1066]: info: Preload queue cleared Oct 01 21:22:54 volumio volumio[1066]: info: Adding Item to queue: music-library/USB/WD/Musica/Wav/Sting - The Dream Of The Blue Turtles (1984).zip Oct 01 21:22:54 volumio volumio[1066]: info: Exploding uri music-library/USB/WD/Musica/Wav/Sting - The Dream Of The Blue Turtles (1984).zip in service mpd Oct 01 21:22:54 volumio volumio[1066]: info: sendMpdCommand stop took 126 milliseconds Oct 01 21:22:54 volumio volumio[1066]: info: Oct 01 21:22:54 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:22:54 volumio volumio[1066]: info: ControllerMpd::getState Oct 01 21:22:54 volumio volumio[1066]: verbose: ControllerMpd::sendMpdCommand status Oct 01 21:22:54 volumio volumio[1066]: info: Oct 01 21:22:54 volumio volumio[1066]: ---------------------------- MPD announces state update: player Oct 01 21:22:54 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=//extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FWav%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1984).zip&metadata=false Oct 01 21:22:54 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Wav/Sting - The Dream Of The Blue Turtles (1984).zip Oct 01 21:22:54 volumio volumio[1066]: info: ALBUMART /albumart?cacheid=401&web=//extralarge&path=%2Fmnt%2FUSB%2FWD%2FMusica%2FWav%2FSting%20-%20The%20Dream%20Of%20The%20Blue%20Turtles%20(1984).zip&metadata=false Oct 01 21:22:54 volumio volumio[1066]: info: URI /mnt/USB/WD/Musica/Wav/Sting - The Dream Of The Blue Turtles (1984).zip Oct 01 21:22:54 volumio volumio[1066]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 21:22:54 volumio volumio[1066]: Error: Unable to resolve or reject the same promise twice Oct 01 21:22:54 volumio volumio[1066]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 01 21:22:54 volumio volumio[1066]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Oct 01 21:22:54 volumio volumio[1066]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 01 21:22:54 volumio volumio[1066]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 01 21:22:54 volumio volumio[1066]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 01 21:22:54 volumio volumio[1066]: at Socket.emit (events.js:400:28) Oct 01 21:22:54 volumio volumio[1066]: at addChunk (internal/streams/readable.js:293:12) Oct 01 21:22:54 volumio volumio[1066]: at readableAddChunk (internal/streams/readable.js:263:11) Oct 01 21:22:54 volumio volumio[1066]: at Socket.Readable.push (internal/streams/readable.js:206:10) Oct 01 21:22:54 volumio volumio[1066]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Oct 01 21:22:54 volumio volumio[1066]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 01 21:22:54 volumio sudo[2478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-01 21:21 Oct 01 21:22:54 volumio sudo[2478]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"