May 18 12:30:00 volumio-alpha go-librespot[1640]: time="2025-05-18T12:30:00+01:00" level=trace msg="sent dealer ping" May 18 12:30:00 volumio-alpha go-librespot[1640]: time="2025-05-18T12:30:00+01:00" level=trace msg="received dealer pong" May 18 12:30:06 volumio-alpha go-librespot[1640]: time="2025-05-18T12:30:06+01:00" level=trace msg="received accesspoint ping" May 18 12:30:06 volumio-alpha go-librespot[1640]: time="2025-05-18T12:30:06+01:00" level=trace msg="received accesspoint pong ack" May 18 12:30:16 volumio-alpha wpa_supplicant[1205]: RRM: Ignoring radio measurement request: Not RRM network May 18 12:30:16 volumio-alpha volumio[1387]: info: Preload queue cleared May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioReplaceandPlayItems May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreStateMachine::ClearQueue May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreStateMachine::stop May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreStateMachine::stPlaybackTimer May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreStateMachine::updateTrackBlock May 18 12:30:16 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrackBlock May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreStateMachine::pushState May 18 12:30:16 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioPushState May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreStateMachine::serviceStop May 18 12:30:16 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreCommandRouter::serviceStop May 18 12:30:16 volumio-alpha volumio[1387]: info: [1747567816980] ControllerWebradio::stop May 18 12:30:16 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand stop May 18 12:30:16 volumio-alpha volumio[1387]: info: CorePlayQueue::clearPlayQueue May 18 12:30:16 volumio-alpha volumio[1387]: info: CorePlayQueue::saveQueue May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioPushQueue May 18 12:30:16 volumio-alpha volumio[1387]: info: CoreStateMachine::addQueueItems May 18 12:30:16 volumio-alpha volumio[1387]: info: CorePlayQueue::addQueueItems May 18 12:30:16 volumio-alpha volumio[1387]: info: Preload queue cleared May 18 12:30:16 volumio-alpha volumio[1387]: info: Adding Item to queue: music-library/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E May 18 12:30:16 volumio-alpha volumio[1387]: info: Exploding uri music-library/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E in service mpd May 18 12:30:16 volumio-alpha volumio[1387]: info: May 18 12:30:16 volumio-alpha volumio[1387]: ---------------------------- MPD announces state update: player May 18 12:30:16 volumio-alpha volumio[1387]: info: sendMpdCommand stop took 17 milliseconds May 18 12:30:16 volumio-alpha volumio[1387]: info: ControllerMpd::getState May 18 12:30:16 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand status May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FAfton%20Water_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Afton Water_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FAnon%20I%20Know%20Where%20I'm%20Going_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Anon I Know Where I'm Going_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FAnon%20Willow%20Song_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Anon Willow Song_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FDashing%20Away%20With%20The%20Smoothing%20Iron_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Dashing Away With The Smoothing Iron_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FDown%20By%20The%20Sally%20Gardens_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Down By The Sally Gardens_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FJust%20As%20The%20Tide%20Was%20Flowing_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Just As The Tide Was Flowing_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FO%20Can%20Ye%20Sew%20Cushions_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/O Can Ye Sew Cushions_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FO%20Waly%2C%20Waly_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/O Waly, Waly_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FSearching%20For%20Lambs_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Searching For Lambs_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FShe%20Moved%20Through%20The%20Fair_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/She Moved Through The Fair_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FShe's%20Like%20The%20Swallow_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/She's Like The Swallow_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Bold%20Grenadier_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Bold Grenadier_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20British%20Grenadiers_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The British Grenadiers_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Cuckoo_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Cuckoo_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Dark%20Eyed%20Sailor_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Dark Eyed Sailor_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Girl%20I%20Left%20Behind%20Me_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Girl I Left Behind Me_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Lark%20In%20The%20Clear%20Air_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Lark In The Clear Air_The Cambridge Singers.mp3 May 18 12:30:16 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Lover's%20Ghost_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:16 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Lover's Ghost_The Cambridge Singers.mp3 May 18 12:30:17 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Miller%20Of%20Dee_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:17 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Miller Of Dee_The Cambridge Singers.mp3 May 18 12:30:17 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Sprig%20Of%20Thyme_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:17 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Sprig Of Thyme_The Cambridge Singers.mp3 May 18 12:30:17 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Spring%20Time%20Of%20The%20Year_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:17 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Spring Time Of The Year_The Cambridge Singers.mp3 May 18 12:30:17 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FThe%20Willow%20Tree_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:17 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/The Willow Tree_The Cambridge Singers.mp3 May 18 12:30:17 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FTrad%20Golden%20Slumbers_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:17 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Trad Golden Slumbers_The Cambridge Singers.mp3 May 18 12:30:17 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FTrad%20The%20Keel%20Row_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:17 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Trad The Keel Row_The Cambridge Singers.mp3 May 18 12:30:17 volumio-alpha volumio[1387]: info: ALBUMART /albumart?cacheid=119&web=The%20Cambridge%20Singers/The%20Sprig%20Of%20Thyme/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FWonder%20MP3%2FRutter%20%20The%20Sprig%20of%20Thyme%20%20%20Vaughan%20Williams%20%205%20E%2FWassail%20Song%20(from%20Five%20English%20Folk%20Songs)_The%20Cambridge%20Singers.mp3&metadata=false May 18 12:30:17 volumio-alpha volumio[1387]: info: URI /mnt/NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Wassail Song (from Five English Folk Songs)_The Cambridge Singers.mp3 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioPushQueue May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::saveQueue May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::updateTrackBlock May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrackBlock May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioPlay May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::play index 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::stop May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::play index undefined May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::startPlaybackTimer May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Afton Water_The Cambridge Singers.mp3 May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand stop May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand status took 6 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand stop took 0 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::parseState May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand clear May 18 12:30:17 volumio-alpha volumio[1387]: info: May 18 12:30:17 volumio-alpha volumio[1387]: ---------------------------- MPD announces system playlist update May 18 12:30:17 volumio-alpha volumio[1387]: info: Ignoring MPD Status Update May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand playlistinfo took 1 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand clear took 1 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::parseTrackInfo May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Afton Water_The Cambridge Singers.mp3" May 18 12:30:17 volumio-alpha volumio[1387]: info: ControllerMpd::pushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::servicePushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::pushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioPushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: 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":"Nikolay Rimsky-Korsakov - Capriccio Espagnol Opus 34","artist":"Classic FM","album":null,"uri":"https://media-ssl.musicradio.com/ClassicFMMP3","trackType":""} May 18 12:30:17 volumio-alpha volumio[1387]: verbose: CURRENT POSITION 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::syncState stateService stop May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::syncState currentStatus stop May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::pushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioPushState May 18 12:30:17 volumio-alpha volumio[1387]: info: No code May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::pushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioPushState May 18 12:30:17 volumio-alpha volumio[1387]: info: ------------------------------ 11ms May 18 12:30:17 volumio-alpha volumio[1387]: error: updateQueue error: null May 18 12:30:17 volumio-alpha volumio[1387]: info: May 18 12:30:17 volumio-alpha volumio[1387]: ---------------------------- MPD announces system playlist update May 18 12:30:17 volumio-alpha volumio[1387]: info: Ignoring MPD Status Update May 18 12:30:17 volumio-alpha volumio[1387]: info: ------------------------------ 4ms May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand add "NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Afton Water_The Cambridge Singers.mp3" took 3 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand play May 18 12:30:17 volumio-alpha volumio[1387]: info: ------------------------------ 2ms May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand play took 2 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: info: May 18 12:30:17 volumio-alpha volumio[1387]: ---------------------------- MPD announces state update: player May 18 12:30:17 volumio-alpha volumio[1387]: info: ControllerMpd::getState May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand status May 18 12:30:17 volumio-alpha volumio[1387]: info: May 18 12:30:17 volumio-alpha volumio[1387]: ---------------------------- MPD announces state update: player May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand status took 24 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: info: ControllerMpd::getState May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand status May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::parseState May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand status took 1 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand playlistinfo took 0 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::parseState May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::parseTrackInfo May 18 12:30:17 volumio-alpha volumio[1387]: info: ControllerMpd::pushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::servicePushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Afton Water","artist":"The Cambridge Singers","album":"The Sprig Of Thyme","uri":"NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Afton Water_The Cambridge Singers.mp3","trackType":"mp3"} May 18 12:30:17 volumio-alpha volumio[1387]: verbose: CURRENT POSITION 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::syncState stateService play May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::syncState currentStatus stop May 18 12:30:17 volumio-alpha volumio[1387]: info: ------------------------------ 26ms May 18 12:30:17 volumio-alpha volumio[1387]: info: sendMpdCommand playlistinfo took 1 milliseconds May 18 12:30:17 volumio-alpha volumio[1387]: verbose: ControllerMpd::parseTrackInfo May 18 12:30:17 volumio-alpha volumio[1387]: info: ControllerMpd::pushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::servicePushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: verbose: STATE SERVICE {"status":"play","position":0,"seek":968,"duration":234,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Afton Water","artist":"The Cambridge Singers","album":"The Sprig Of Thyme","uri":"NAS/Music/Wonder MP3/Rutter The Sprig of Thyme Vaughan Williams 5 E/Afton Water_The Cambridge Singers.mp3","trackType":"mp3"} May 18 12:30:17 volumio-alpha volumio[1387]: verbose: CURRENT POSITION 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::syncState stateService play May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::syncState currentStatus play May 18 12:30:17 volumio-alpha volumio[1387]: info: Received an update from plugin. extracting info from payload May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::pushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioPushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreStateMachine::pushState May 18 12:30:17 volumio-alpha volumio[1387]: info: CorePlayQueue::getTrack 0 May 18 12:30:17 volumio-alpha volumio[1387]: info: CoreCommandRouter::volumioPushState May 18 12:30:17 volumio-alpha volumio[1387]: info: ------------------------------ 6ms May 18 12:30:30 volumio-alpha go-librespot[1640]: time="2025-05-18T12:30:30+01:00" level=trace msg="sent dealer ping" May 18 12:30:30 volumio-alpha go-librespot[1640]: time="2025-05-18T12:30:30+01:00" level=trace msg="received dealer pong" May 18 12:30:34 volumio-alpha wpa_supplicant[1205]: RRM: Ignoring radio measurement request: Not RRM network May 18 12:30:37 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 18 12:30:37 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 18 12:30:48 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 18 12:30:48 volumio-alpha systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 18 12:30:48 volumio-alpha dbus-daemon[889]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.6396' (uid=0 pid=3767 comm="timedatectl show --property=NTPSynchronized --valu") May 18 12:30:48 volumio-alpha systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 18 12:30:48 volumio-alpha dbus-daemon[889]: [system] Successfully activated service 'org.freedesktop.timedate1' May 18 12:30:48 volumio-alpha systemd[1]: Started systemd-timedated.service - Time & Date Service. May 18 12:30:48 volumio-alpha setdatetime-helper.sh[3766]: Time is already synchronized. May 18 12:30:48 volumio-alpha systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 18 12:30:48 volumio-alpha systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 18 12:30:54 volumio-alpha wpa_supplicant[1205]: RRM: Ignoring radio measurement request: Not RRM network May 18 12:30:58 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 18 12:30:59 volumio-alpha volumio[1387]: info: Preload queue cleared May 18 12:31:00 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 18 12:31:00 volumio-alpha go-librespot[1640]: time="2025-05-18T12:31:00+01:00" level=trace msg="sent dealer ping" May 18 12:31:00 volumio-alpha go-librespot[1640]: time="2025-05-18T12:31:00+01:00" level=trace msg="received dealer pong" May 18 12:31:00 volumio-alpha volumio[1387]: info: Preload queue cleared May 18 12:31:02 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 18 12:31:02 volumio-alpha volumio[1387]: info: Preload queue cleared May 18 12:31:08 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 18 12:31:08 volumio-alpha volumio[1387]: info: Preload queue cleared May 18 12:31:15 volumio-alpha wpa_supplicant[1205]: RRM: Ignoring radio measurement request: Not RRM network May 18 12:31:16 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 18 12:31:18 volumio-alpha systemd[1]: systemd-timedated.service: Deactivated successfully. May 18 12:31:19 volumio-alpha wpa_supplicant[1205]: RRM: Ignoring radio measurement request: Not RRM network May 18 12:31:22 volumio-alpha volumio[1387]: info: Preload queue cleared May 18 12:31:25 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 18 12:31:27 volumio-alpha volumio[1387]: info: Preload queue cleared May 18 12:31:30 volumio-alpha go-librespot[1640]: time="2025-05-18T12:31:30+01:00" level=trace msg="sent dealer ping" May 18 12:31:30 volumio-alpha go-librespot[1640]: time="2025-05-18T12:31:30+01:00" level=trace msg="received dealer pong" May 18 12:31:34 volumio-alpha wpa_supplicant[1205]: RRM: Ignoring radio measurement request: Not RRM network May 18 12:31:44 volumio-alpha volumio[1387]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 18 12:31:44 volumio-alpha volumio[1387]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 12:31:44 volumio-alpha volumio[1387]: TypeError: Cannot read properties of undefined (reading 'length') May 18 12:31:44 volumio-alpha volumio[1387]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 18 12:31:44 volumio-alpha volumio[1387]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 18 12:31:44 volumio-alpha volumio[1387]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 18 12:31:44 volumio-alpha volumio[1387]: at Parser.emit (node:events:514:28) May 18 12:31:44 volumio-alpha volumio[1387]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 18 12:31:44 volumio-alpha volumio[1387]: at emit (/volumio/node_modules/sax/lib/sax.js:625:35) May 18 12:31:44 volumio-alpha volumio[1387]: at emitNode (/volumio/node_modules/sax/lib/sax.js:630:5) May 18 12:31:44 volumio-alpha volumio[1387]: at closeTag (/volumio/node_modules/sax/lib/sax.js:890:7) May 18 12:31:44 volumio-alpha volumio[1387]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1437:13) May 18 12:31:44 volumio-alpha volumio[1387]: at exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 18 12:31:44 volumio-alpha volumio[1387]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 18 12:31:44 volumio-alpha volumio[1387]: at exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 18 12:31:44 volumio-alpha volumio[1387]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 18 12:31:44 volumio-alpha volumio[1387]: at IncomingMessage.emit (node:events:526:35) May 18 12:31:44 volumio-alpha volumio[1387]: at endReadableNT (node:internal/streams/readable:1376:12) May 18 12:31:44 volumio-alpha volumio[1387]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) May 18 12:31:44 volumio-alpha volumio[1387]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 12:31:44 volumio-alpha sudo[3859]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-18 12:30' May 18 12:31:44 volumio-alpha sudo[3859]: 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="74e551e797a3a333b0b20739125f2f8b0b974aba" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed May 14 16:06:36 UTC 2025" VOLUMIO_VERSION="0.066" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="72f9e088cb36b840954a7bc22b48bde7"