Aug 31 12:10:06 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 12:10:06 volumio volumio[1267]: info: CURURI: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t] Aug 31 12:10:06 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:10:06 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (9).wv Aug 31 12:10:06 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (3).wv Aug 31 12:10:06 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (7).wv Aug 31 12:10:06 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (4).wv Aug 31 12:10:06 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (5).wv Aug 31 12:10:06 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (10).wv Aug 31 12:10:06 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (6).wv Aug 31 12:10:06 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (2).wv Aug 31 12:10:06 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (8).wv Aug 31 12:10:06 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (9).wv in service mpd Aug 31 12:10:06 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (3).wv in service mpd Aug 31 12:10:06 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=RICCHI%20E%20POVERI/RICCHI%20E%20POVERI%20%201988/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5B32.192%5D%20RICCHI%20E%20POVERI%20%201988%20%5Bfrfr%3Bt%5D%2FRICCHI%20E%20POVERI%20%201988%20(9).wv&metadata=false Aug 31 12:10:06 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (9).wv Aug 31 12:10:06 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=RICCHI%20E%20POVERI/RICCHI%20E%20POVERI%20%201988/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5B32.192%5D%20RICCHI%20E%20POVERI%20%201988%20%5Bfrfr%3Bt%5D%2FRICCHI%20E%20POVERI%20%201988%20(3).wv&metadata=false Aug 31 12:10:06 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (3).wv Aug 31 12:10:06 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (7).wv in service mpd Aug 31 12:10:06 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=RICCHI%20E%20POVERI/RICCHI%20E%20POVERI%20%201988/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5B32.192%5D%20RICCHI%20E%20POVERI%20%201988%20%5Bfrfr%3Bt%5D%2FRICCHI%20E%20POVERI%20%201988%20(7).wv&metadata=false Aug 31 12:10:06 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (7).wv Aug 31 12:10:06 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (4).wv in service mpd Aug 31 12:10:06 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=RICCHI%20E%20POVERI/RICCHI%20E%20POVERI%20%201988/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5B32.192%5D%20RICCHI%20E%20POVERI%20%201988%20%5Bfrfr%3Bt%5D%2FRICCHI%20E%20POVERI%20%201988%20(4).wv&metadata=false Aug 31 12:10:06 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (4).wv Aug 31 12:10:06 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (5).wv in service mpd Aug 31 12:10:06 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=RICCHI%20E%20POVERI/RICCHI%20E%20POVERI%20%201988/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5B32.192%5D%20RICCHI%20E%20POVERI%20%201988%20%5Bfrfr%3Bt%5D%2FRICCHI%20E%20POVERI%20%201988%20(5).wv&metadata=false Aug 31 12:10:06 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (5).wv Aug 31 12:10:06 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (10).wv in service mpd Aug 31 12:10:06 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=RICCHI%20E%20POVERI/RICCHI%20E%20POVERI%20%201988/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5B32.192%5D%20RICCHI%20E%20POVERI%20%201988%20%5Bfrfr%3Bt%5D%2FRICCHI%20E%20POVERI%20%201988%20(10).wv&metadata=false Aug 31 12:10:06 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (10).wv Aug 31 12:10:06 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (6).wv in service mpd Aug 31 12:10:06 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=RICCHI%20E%20POVERI/RICCHI%20E%20POVERI%20%201988/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5B32.192%5D%20RICCHI%20E%20POVERI%20%201988%20%5Bfrfr%3Bt%5D%2FRICCHI%20E%20POVERI%20%201988%20(6).wv&metadata=false Aug 31 12:10:06 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (6).wv Aug 31 12:10:06 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (2).wv in service mpd Aug 31 12:10:06 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=RICCHI%20E%20POVERI/RICCHI%20E%20POVERI%20%201988/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5B32.192%5D%20RICCHI%20E%20POVERI%20%201988%20%5Bfrfr%3Bt%5D%2FRICCHI%20E%20POVERI%20%201988%20(2).wv&metadata=false Aug 31 12:10:06 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (2).wv Aug 31 12:10:06 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (8).wv in service mpd Aug 31 12:10:07 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=RICCHI%20E%20POVERI/RICCHI%20E%20POVERI%20%201988/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5B32.192%5D%20RICCHI%20E%20POVERI%20%201988%20%5Bfrfr%3Bt%5D%2FRICCHI%20E%20POVERI%20%201988%20(8).wv&metadata=false Aug 31 12:10:07 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t]/RICCHI E POVERI 1988 (8).wv Aug 31 12:10:19 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 12:10:19 volumio volumio[1267]: info: CURURI: music-library/USB/B268C64A806044EB/[SACD-R] [OF] The Cardigans - First Band On The Moon (Pop-Rock, Alt-Rock) Aug 31 12:10:19 volumio volumio[1267]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 31 12:10:19 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:10:30 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 12:10:30 volumio volumio[1267]: info: CURURI: music-library/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021) Aug 31 12:10:30 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:10:30 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac Aug 31 12:10:30 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/B. Trance Classics Pres. Enigma State - Enigmatic.flac Aug 31 12:10:30 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac in service mpd Aug 31 12:10:30 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Enigma%20State/In%20My%20Fantasy%20%2F%20Enigmatic/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5BFLAC%5D%20Trance%20Classics%20Pres.%20Enigma%20State%20-%20In%20My%20Fantasy%2C%20Enigmatic%20(2021)%2FA.%20Trance%20Classics%20Pres.%20Enigma%20State%20-%20In%20My%20Fantasy.flac&metadata=false Aug 31 12:10:30 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac Aug 31 12:10:30 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/B. Trance Classics Pres. Enigma State - Enigmatic.flac in service mpd Aug 31 12:10:30 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Enigma%20State/In%20My%20Fantasy%20%2F%20Enigmatic/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5BFLAC%5D%20Trance%20Classics%20Pres.%20Enigma%20State%20-%20In%20My%20Fantasy%2C%20Enigmatic%20(2021)%2FB.%20Trance%20Classics%20Pres.%20Enigma%20State%20-%20Enigmatic.flac&metadata=false Aug 31 12:10:30 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/B. Trance Classics Pres. Enigma State - Enigmatic.flac Aug 31 12:10:37 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 12:10:37 volumio volumio[1267]: info: CURURI: music-library/USB/B268C64A806044EB/[SACD-R] [OF] The Cardigans - First Band On The Moon (Pop-Rock, Alt-Rock) Aug 31 12:10:37 volumio volumio[1267]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Aug 31 12:10:37 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:10:46 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 12:10:46 volumio volumio[1267]: info: CURURI: music-library/USB/B268C64A806044EB Aug 31 12:10:46 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:10:54 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 12:10:54 volumio volumio[1267]: info: CURURI: music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982 Aug 31 12:10:54 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:10:54 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (4).wv Aug 31 12:10:54 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv Aug 31 12:10:54 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (3).wv Aug 31 12:10:54 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (2).wv Aug 31 12:10:54 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (3).wv Aug 31 12:10:54 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (5).wv Aug 31 12:10:54 volumio volumio[1267]: info: Preloading song: music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (4).wv Aug 31 12:10:54 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (4).wv in service mpd Aug 31 12:10:54 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S1%20(4).wv&metadata=false Aug 31 12:10:54 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (4).wv Aug 31 12:10:54 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv in service mpd Aug 31 12:10:54 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S1%20(2).wv&metadata=false Aug 31 12:10:54 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv Aug 31 12:10:54 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (3).wv in service mpd Aug 31 12:10:54 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S1%20(3).wv&metadata=false Aug 31 12:10:54 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (3).wv Aug 31 12:10:54 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (2).wv in service mpd Aug 31 12:10:54 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S2%20(2).wv&metadata=false Aug 31 12:10:54 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (2).wv Aug 31 12:10:54 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (3).wv in service mpd Aug 31 12:10:54 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S2%20(3).wv&metadata=false Aug 31 12:10:54 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (3).wv Aug 31 12:10:54 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (5).wv in service mpd Aug 31 12:10:54 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S2%20(5).wv&metadata=false Aug 31 12:10:54 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (5).wv Aug 31 12:10:55 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (4).wv in service mpd Aug 31 12:10:55 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S2%20(4).wv&metadata=false Aug 31 12:10:55 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (4).wv Aug 31 12:11:01 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 12:11:01 volumio volumio[1267]: info: CURURI: music-library/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021 Aug 31 12:11:01 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:11:07 volumio kernel: usb 1-1.2: new high-speed USB device number 7 using xhci_hcd Aug 31 12:11:07 volumio kernel: usb 1-1.2: New USB device found, idVendor=05e3, idProduct=0610, bcdDevice=60.60 Aug 31 12:11:07 volumio kernel: usb 1-1.2: New USB device strings: Mfr=0, Product=1, SerialNumber=0 Aug 31 12:11:07 volumio kernel: usb 1-1.2: Product: USB2.0 Hub Aug 31 12:11:07 volumio kernel: hub 1-1.2:1.0: USB hub found Aug 31 12:11:07 volumio kernel: hub 1-1.2:1.0: 4 ports detected Aug 31 12:11:10 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 31 12:11:10 volumio volumio[1267]: info: CURURI: music-library/USB/B268C64A806044EB/[32.192] RICCHI E POVERI 1988 [frfr;t] Aug 31 12:11:10 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:11:16 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::ClearQueue Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::stop Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::stPlaybackTimer Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::updateTrackBlock Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrackBlock Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::serviceStop Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::serviceStop Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::stop Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::clearPlayQueue Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::saveQueue Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushQueue Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::addQueueItems Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::addQueueItems Aug 31 12:11:16 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:11:16 volumio volumio[1267]: info: Adding Item to queue: music-library/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021) Aug 31 12:11:16 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021) in service mpd Aug 31 12:11:16 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Enigma%20State/In%20My%20Fantasy%20%2F%20Enigmatic/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5BFLAC%5D%20Trance%20Classics%20Pres.%20Enigma%20State%20-%20In%20My%20Fantasy%2C%20Enigmatic%20(2021)%2FA.%20Trance%20Classics%20Pres.%20Enigma%20State%20-%20In%20My%20Fantasy.flac&metadata=false Aug 31 12:11:16 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac Aug 31 12:11:16 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Enigma%20State/In%20My%20Fantasy%20%2F%20Enigmatic/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%5BFLAC%5D%20Trance%20Classics%20Pres.%20Enigma%20State%20-%20In%20My%20Fantasy%2C%20Enigmatic%20(2021)%2FB.%20Trance%20Classics%20Pres.%20Enigma%20State%20-%20Enigmatic.flac&metadata=false Aug 31 12:11:16 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/B. Trance Classics Pres. Enigma State - Enigmatic.flac Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand stop took 74 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushQueue Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::saveQueue Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::updateTrackBlock Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrackBlock Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPlay Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::play index 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::stop Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::play index undefined Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::startPlaybackTimer Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::clearAddPlayTracks USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:16 volumio volumio[1267]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand status took 25 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand stop took 7 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand status took 7 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand status took 4 milliseconds Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:16 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand clear took 9 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand add "USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac" Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: 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":"Under Cover Lover (Extended Version)","artist":"T.Ark","album":"H.A.P.P.Y. Radio","uri":"USB/B268C64A806044EB/! T.Ark - H.A.P.P.Y. Radio (ESonCD)/T.Ark - H.A.P.P.Y. Radio.flac","trackType":"flac"} Aug 31 12:11:16 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState stateService stop Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus stop Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: No code Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Aug 31 12:11:16 volumio volumio[1267]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 86ms Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 66ms Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 65ms Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:16 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:16 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:16 volumio volumio[1267]: error: updateQueue error: null Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:16 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 54ms Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand add "USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac" took 51 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 6ms Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 4ms Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand play Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:16 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:16 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 22ms Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand play took 20 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 19ms Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 17ms Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand status took 6 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand status took 3 milliseconds Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:16 volumio volumio[1267]: info: Aug 31 12:11:16 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand status took 11 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand status took 10 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand status took 5 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand status took 3 milliseconds Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":554,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"In My Fantasy","artist":"Enigma State","album":"In My Fantasy / Enigmatic","uri":"USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac","trackType":"flac"} Aug 31 12:11:16 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus stop Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":554,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"In My Fantasy","artist":"Enigma State","album":"In My Fantasy / Enigmatic","uri":"USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac","trackType":"flac"} Aug 31 12:11:16 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:16 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 61ms Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 77ms Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 62 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 63 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 59 milliseconds Aug 31 12:11:16 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 59 milliseconds Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:16 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":554,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"In My Fantasy","artist":"Enigma State","album":"In My Fantasy / Enigmatic","uri":"USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac","trackType":"flac"} Aug 31 12:11:16 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:16 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":554,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"In My Fantasy","artist":"Enigma State","album":"In My Fantasy / Enigmatic","uri":"USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac","trackType":"flac"} Aug 31 12:11:16 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:16 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":554,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"In My Fantasy","artist":"Enigma State","album":"In My Fantasy / Enigmatic","uri":"USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac","trackType":"flac"} Aug 31 12:11:16 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:16 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":554,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"In My Fantasy","artist":"Enigma State","album":"In My Fantasy / Enigmatic","uri":"USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac","trackType":"flac"} Aug 31 12:11:16 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:16 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:16 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:16 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 171ms Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 171ms Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 170ms Aug 31 12:11:16 volumio volumio[1267]: info: ------------------------------ 169ms Aug 31 12:11:21 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::ClearQueue Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::stop Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::stPlaybackTimer Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::updateTrackBlock Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrackBlock Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::serviceStop Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::serviceStop Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::stop Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::clearPlayQueue Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::saveQueue Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushQueue Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::addQueueItems Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::addQueueItems Aug 31 12:11:21 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:11:21 volumio volumio[1267]: info: Adding Item to queue: music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982 Aug 31 12:11:21 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982 in service mpd Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand stop took 63 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:21 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S1%20(2).wv&metadata=false Aug 31 12:11:21 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv Aug 31 12:11:21 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S1%20(3).wv&metadata=false Aug 31 12:11:21 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (3).wv Aug 31 12:11:21 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S1%20(4).wv&metadata=false Aug 31 12:11:21 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (4).wv Aug 31 12:11:21 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S2%20(2).wv&metadata=false Aug 31 12:11:21 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (2).wv Aug 31 12:11:21 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S2%20(3).wv&metadata=false Aug 31 12:11:21 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (3).wv Aug 31 12:11:21 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S2%20(4).wv&metadata=false Aug 31 12:11:21 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (4).wv Aug 31 12:11:21 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=Berlin/Pleasure%20Victim/extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Berlin%20%5BPleasure%20Victim%5D%20-%201982%2FBerlin%20S2%20(5).wv&metadata=false Aug 31 12:11:21 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S2 (5).wv Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand status took 11 milliseconds Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushQueue Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::saveQueue Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::updateTrackBlock Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrackBlock Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPlay Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::play index 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::stop Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::play index undefined Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::startPlaybackTimer Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::clearAddPlayTracks USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand status took 21 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand status took 20 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 11 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand stop took 2 milliseconds Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand clear Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: 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":"In My Fantasy","artist":"Enigma State","album":"In My Fantasy / Enigmatic","uri":"USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac","trackType":"flac"} Aug 31 12:11:21 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState stateService stop Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus stop Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: No code Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 63ms Aug 31 12:11:21 volumio volumio[1267]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:21 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 58 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 58 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand clear took 58 milliseconds Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand add "USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv" Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: 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":"In My Fantasy","artist":"Enigma State","album":"In My Fantasy / Enigmatic","uri":"USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac","trackType":"flac"} Aug 31 12:11:21 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState stateService stop Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus stop Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: No code Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: 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":"In My Fantasy","artist":"Enigma State","album":"In My Fantasy / Enigmatic","uri":"USB/B268C64A806044EB/[FLAC] Trance Classics Pres. Enigma State - In My Fantasy, Enigmatic (2021)/A. Trance Classics Pres. Enigma State - In My Fantasy.flac","trackType":"flac"} Aug 31 12:11:21 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState stateService stop Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus stop Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: No code Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 144ms Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 144ms Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:21 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:21 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:21 volumio volumio[1267]: error: updateQueue error: null Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:21 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 70ms Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand add "USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv" took 68 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 4ms Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 3ms Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand play Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:21 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces system playlist update Aug 31 12:11:21 volumio volumio[1267]: info: Ignoring MPD Status Update Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 48ms Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand play took 46 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 47ms Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 45ms Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand status took 4 milliseconds Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand status took 7 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand status took 5 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand status took 5 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand status took 2 milliseconds Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Pleasure Victim","artist":"Berlin","album":"Pleasure Victim","uri":"USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv","trackType":"wv"} Aug 31 12:11:21 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus stop Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 15ms Aug 31 12:11:21 volumio volumio[1267]: info: Aug 31 12:11:21 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand status took 2 milliseconds Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseState Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Pleasure Victim","artist":"Berlin","album":"Pleasure Victim","uri":"USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv","trackType":"wv"} Aug 31 12:11:21 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:21 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Pleasure Victim","artist":"Berlin","album":"Pleasure Victim","uri":"USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv","trackType":"wv"} Aug 31 12:11:21 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:21 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Pleasure Victim","artist":"Berlin","album":"Pleasure Victim","uri":"USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv","trackType":"wv"} Aug 31 12:11:21 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:21 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Pleasure Victim","artist":"Berlin","album":"Pleasure Victim","uri":"USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv","trackType":"wv"} Aug 31 12:11:21 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:21 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 132ms Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 132ms Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 131ms Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 129ms Aug 31 12:11:21 volumio volumio[1267]: info: sendMpdCommand playlistinfo took 116 milliseconds Aug 31 12:11:21 volumio volumio[1267]: verbose: ControllerMpd::parseTrackInfo Aug 31 12:11:21 volumio volumio[1267]: info: ControllerMpd::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::servicePushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"192 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Pleasure Victim","artist":"Berlin","album":"Pleasure Victim","uri":"USB/B268C64A806044EB/♪ Berlin [Pleasure Victim] - 1982/Berlin S1 (2).wv","trackType":"wv"} Aug 31 12:11:21 volumio volumio[1267]: verbose: CURRENT POSITION 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState stateService play Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::syncState currentStatus play Aug 31 12:11:21 volumio volumio[1267]: info: Received an update from plugin. extracting info from payload Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:21 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:21 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:21 volumio volumio[1267]: info: ------------------------------ 148ms Aug 31 12:11:25 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:11:25 volumio volumio[1267]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 31 12:11:25 volumio volumio[1267]: info: CoreStateMachine::ClearQueue Aug 31 12:11:25 volumio volumio[1267]: info: CoreStateMachine::stop Aug 31 12:11:25 volumio volumio[1267]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 31 12:11:25 volumio volumio[1267]: info: CoreStateMachine::stPlaybackTimer Aug 31 12:11:25 volumio volumio[1267]: info: CoreStateMachine::updateTrackBlock Aug 31 12:11:25 volumio volumio[1267]: info: CorePlayQueue::getTrackBlock Aug 31 12:11:25 volumio volumio[1267]: info: CoreStateMachine::pushState Aug 31 12:11:25 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:25 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 12:11:25 volumio volumio[1267]: info: CoreCommandRouter::volumioPushState Aug 31 12:11:25 volumio volumio[1267]: info: CoreStateMachine::serviceStop Aug 31 12:11:25 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Aug 31 12:11:25 volumio volumio[1267]: info: CoreCommandRouter::serviceStop Aug 31 12:11:25 volumio volumio[1267]: info: ControllerMpd::stop Aug 31 12:11:25 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand stop Aug 31 12:11:25 volumio volumio[1267]: info: CorePlayQueue::clearPlayQueue Aug 31 12:11:25 volumio volumio[1267]: info: CorePlayQueue::saveQueue Aug 31 12:11:25 volumio volumio[1267]: info: CoreCommandRouter::volumioPushQueue Aug 31 12:11:25 volumio volumio[1267]: info: CoreStateMachine::addQueueItems Aug 31 12:11:25 volumio volumio[1267]: info: CorePlayQueue::addQueueItems Aug 31 12:11:25 volumio volumio[1267]: info: Preload queue cleared Aug 31 12:11:25 volumio volumio[1267]: info: Adding Item to queue: music-library/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021 Aug 31 12:11:25 volumio volumio[1267]: info: Exploding uri music-library/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021 in service mpd Aug 31 12:11:25 volumio volumio[1267]: info: sendMpdCommand stop took 78 milliseconds Aug 31 12:11:25 volumio volumio[1267]: info: Aug 31 12:11:25 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:25 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:25 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:25 volumio volumio[1267]: info: Aug 31 12:11:25 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:25 volumio volumio[1267]: info: ControllerMpd::getState Aug 31 12:11:25 volumio volumio[1267]: verbose: ControllerMpd::sendMpdCommand status Aug 31 12:11:25 volumio volumio[1267]: info: Aug 31 12:11:25 volumio volumio[1267]: ---------------------------- MPD announces state update: player Aug 31 12:11:25 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Iron%20Maiden%20%5BSenjutsu%5D%20-%202021%2FIron%20Maiden%20Side%20A.wv&metadata=false Aug 31 12:11:25 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021/Iron Maiden Side A.wv Aug 31 12:11:25 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Iron%20Maiden%20%5BSenjutsu%5D%20-%202021%2FIron%20Maiden%20Side%20B.wv&metadata=false Aug 31 12:11:25 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021/Iron Maiden Side B.wv Aug 31 12:11:25 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Iron%20Maiden%20%5BSenjutsu%5D%20-%202021%2FIron%20Maiden%20Side%20C.wv&metadata=false Aug 31 12:11:25 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021/Iron Maiden Side C.wv Aug 31 12:11:25 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Iron%20Maiden%20%5BSenjutsu%5D%20-%202021%2FIron%20Maiden%20Side%20D.wv&metadata=false Aug 31 12:11:25 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021/Iron Maiden Side D.wv Aug 31 12:11:25 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Iron%20Maiden%20%5BSenjutsu%5D%20-%202021%2FIron%20Maiden%20Side%20E.wv&metadata=false Aug 31 12:11:25 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021/Iron Maiden Side E.wv Aug 31 12:11:25 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Iron%20Maiden%20%5BSenjutsu%5D%20-%202021%2FIron%20Maiden%20Side%20F.wv&metadata=false Aug 31 12:11:25 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021/Iron Maiden Side F.wv Aug 31 12:11:25 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Iron%20Maiden%20%5BSenjutsu%5D%20-%202021%2FIron%20Maiden.cue&metadata=false Aug 31 12:11:25 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021/Iron Maiden.cue Aug 31 12:11:25 volumio volumio[1267]: info: ALBUMART /albumart?cacheid=602&web=//extralarge&path=%2Fmnt%2FUSB%2FB268C64A806044EB%2F%E2%99%AA%20Iron%20Maiden%20%5BSenjutsu%5D%20-%202021%2FIron%20Maiden.cue&metadata=false Aug 31 12:11:25 volumio volumio[1267]: info: URI /mnt/USB/B268C64A806044EB/♪ Iron Maiden [Senjutsu] - 2021/Iron Maiden.cue Aug 31 12:11:25 volumio volumio[1267]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 12:11:25 volumio volumio[1267]: Error: Unable to resolve or reject the same promise twice Aug 31 12:11:25 volumio volumio[1267]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Aug 31 12:11:25 volumio volumio[1267]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Aug 31 12:11:25 volumio volumio[1267]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Aug 31 12:11:25 volumio volumio[1267]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Aug 31 12:11:25 volumio volumio[1267]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Aug 31 12:11:25 volumio volumio[1267]: at Socket.emit (node:events:514:28) Aug 31 12:11:25 volumio volumio[1267]: at addChunk (node:internal/streams/readable:343:12) Aug 31 12:11:25 volumio volumio[1267]: at readableAddChunk (node:internal/streams/readable:312:11) Aug 31 12:11:25 volumio volumio[1267]: at Readable.push (node:internal/streams/readable:253:10) Aug 31 12:11:25 volumio volumio[1267]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Aug 31 12:11:25 volumio volumio[1267]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 12:11:26 volumio sudo[2631]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-31 12:10' Aug 31 12:11:26 volumio sudo[2631]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"