Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::ClearQueue Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::stop Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::stPlaybackTimer Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::updateTrackBlock Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrackBlock Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::serviceStop Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::serviceStop Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ControllerMpd::stop Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::clearPlayQueue Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::saveQueue Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushQueue Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::addQueueItems Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::addQueueItems Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192] Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192] in service mpd Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.154+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=0 volume=41 Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.155+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/Colgen Band - A Lonely Falling Star (1981, Lob-Japan) [LP 24-192]/01 - A Heavenly Maiden.flac" title="A Heavenly Maiden" Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Apr 13 21:25:07 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F01%20-%20Dream%20Racer%20I.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F02%20-%20Dream%20Racer%20II.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/02 - Dream Racer II.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F03%20-%20Stranger%20I.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/03 - Stranger I.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F04%20-%20Dream%20Racer%20III.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/04 - Dream Racer III.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F05%20-%20Dream%20Racer%20IV.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/05 - Dream Racer IV.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F06%20-%20Stranger%20II.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/06 - Stranger II.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F07%20-%20Matsuribayashi%20ga%20Kikoeru%20no%20Theme.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/07 - Matsuribayashi ga Kikoeru no Theme.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F08%20-%20Dream%20Racer%20V.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/08 - Dream Racer V.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F09%20-%20Stranger%20III.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/09 - Stranger III.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F10%20-%20Dream%20Racer%20VI.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/10 - Dream Racer VI.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F11%20-%20Dream%20Racer%20VII.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/11 - Dream Racer VII.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=George%20Yanagi%20%26%20Nadja%20Band/Matsuribayashi%20ga%20Kikoeru/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FGeorge%20Yanagi%20%26%20Nadja%20Band%20-%20Matsuribayashi%20ga%20Kikoeru%20(1977%2C%20Bourbon-Japan)%20%5BLP%2024-192%5D%2F12%20-%20Stranger%20IV.flac&metadata=false Apr 13 21:25:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/12 - Stranger IV.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand stop took 132 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ControllerMpd::getState Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushQueue Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::saveQueue Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::updateTrackBlock Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrackBlock Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPlay Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::play index 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::stop Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::play index undefined Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::startPlaybackTimer Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::clearAddPlayTracks NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand status took 6 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand stop took 1 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseState Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand clear Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Apr 13 21:25:07 volumio-pisya volumio[1219]: ---------------------------- MPD announces system playlist update Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Ignoring MPD Status Update Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand clear took 3 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand add "NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac" Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ControllerMpd::pushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::servicePushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: 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":"A Heavenly Maiden","artist":"Colgen Band","album":"A Lonely Falling Star","uri":"NAS/Roach/jazz/Colgen Band - A Lonely Falling Star (1981, Lob-Japan) [LP 24-192]/01 - A Heavenly Maiden.flac","trackType":"flac"} Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: CURRENT POSITION 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState stateService stop Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState currentStatus stop Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: No code Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.201+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=1 volume=41 Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.202+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=1 volume=41 Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.202+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=1 volume=41 Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.202+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac" title="Dream Racer I" Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.202+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac" title="Dream Racer I" Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.203+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac" title="Dream Racer I" Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ------------------------------ 30ms Apr 13 21:25:07 volumio-pisya volumio[1219]: error: updateQueue error: null Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Apr 13 21:25:07 volumio-pisya volumio[1219]: ---------------------------- MPD announces system playlist update Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Ignoring MPD Status Update Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ------------------------------ 18ms Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand add "NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac" took 17 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand play Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ------------------------------ 7ms Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand play took 8 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Apr 13 21:25:07 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ControllerMpd::getState Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Apr 13 21:25:07 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ControllerMpd::getState Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand status took 2 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand status took 1 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseState Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseState Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ControllerMpd::pushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::servicePushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dream Racer I","artist":"George Yanagi & Nadja Band","album":"Matsuribayashi ga Kikoeru","uri":"NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac","trackType":"flac"} Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: CURRENT POSITION 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState stateService play Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState currentStatus stop Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ControllerMpd::pushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::servicePushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dream Racer I","artist":"George Yanagi & Nadja Band","album":"Matsuribayashi ga Kikoeru","uri":"NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac","trackType":"flac"} Apr 13 21:25:07 volumio-pisya volumio[1219]: verbose: CURRENT POSITION 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState stateService play Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState currentStatus play Apr 13 21:25:07 volumio-pisya volumio[1219]: info: Received an update from plugin. extracting info from payload Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:07 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:07 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ------------------------------ 15ms Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.350+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_PLAYING positionMs=0 volume=41 Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.350+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_PLAYING positionMs=0 volume=41 Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.351+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac" title="Dream Racer I" Apr 13 21:25:07 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:07.351+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac" title="Dream Racer I" Apr 13 21:25:07 volumio-pisya volumio[1219]: info: ------------------------------ 17ms Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::ClearQueue Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::stop Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::stPlaybackTimer Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::updateTrackBlock Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrackBlock Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::serviceStop Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::serviceStop Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ControllerMpd::stop Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::clearPlayQueue Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::saveQueue Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushQueue Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::addQueueItems Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::addQueueItems Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP] Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP] in service mpd Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.681+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=0 volume=41 Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.681+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac" title="Dream Racer I" Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Apr 13 21:25:24 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand stop took 71 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ControllerMpd::getState Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Hiromasa%20Suzuki/Skip%20Step%20Colgen/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FHiromasa%20Suzuki%20-%20Skip%20Step%20Colgen%20(1977%2C%20Toshiba-Japan)%20%5BLP%5D%2F01%20-%20Skip%20Step.flac&metadata=false Apr 13 21:25:24 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Hiromasa%20Suzuki/Skip%20Step%20Colgen/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FHiromasa%20Suzuki%20-%20Skip%20Step%20Colgen%20(1977%2C%20Toshiba-Japan)%20%5BLP%5D%2F02%20-%20Gentle%20Wave.flac&metadata=false Apr 13 21:25:24 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/02 - Gentle Wave.flac Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Hiromasa%20Suzuki/Skip%20Step%20Colgen/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FHiromasa%20Suzuki%20-%20Skip%20Step%20Colgen%20(1977%2C%20Toshiba-Japan)%20%5BLP%5D%2F03%20-%20Watermelon%20Man.flac&metadata=false Apr 13 21:25:24 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/03 - Watermelon Man.flac Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Hiromasa%20Suzuki/Skip%20Step%20Colgen/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FHiromasa%20Suzuki%20-%20Skip%20Step%20Colgen%20(1977%2C%20Toshiba-Japan)%20%5BLP%5D%2F04%20-%20Orpheus%20Negro.flac&metadata=false Apr 13 21:25:24 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/04 - Orpheus Negro.flac Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Hiromasa%20Suzuki/Skip%20Step%20Colgen/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FHiromasa%20Suzuki%20-%20Skip%20Step%20Colgen%20(1977%2C%20Toshiba-Japan)%20%5BLP%5D%2F05%20-%20Green%20Sleeves.flac&metadata=false Apr 13 21:25:24 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/05 - Green Sleeves.flac Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Hiromasa%20Suzuki/Skip%20Step%20Colgen/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FHiromasa%20Suzuki%20-%20Skip%20Step%20Colgen%20(1977%2C%20Toshiba-Japan)%20%5BLP%5D%2F06%20-%20Georgia%20on%20My%20Mind.flac&metadata=false Apr 13 21:25:24 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/06 - Georgia on My Mind.flac Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Hiromasa%20Suzuki/Skip%20Step%20Colgen/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fjazz%2FHiromasa%20Suzuki%20-%20Skip%20Step%20Colgen%20(1977%2C%20Toshiba-Japan)%20%5BLP%5D%2F07%20-%20Ratafia.flac&metadata=false Apr 13 21:25:24 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/07 - Ratafia.flac Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushQueue Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::saveQueue Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::updateTrackBlock Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrackBlock Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPlay Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::play index 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::stop Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::play index undefined Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::startPlaybackTimer Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::clearAddPlayTracks NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand status took 8 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand stop took 1 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseState Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand clear Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Apr 13 21:25:24 volumio-pisya volumio[1219]: ---------------------------- MPD announces system playlist update Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Ignoring MPD Status Update Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand clear took 4 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand add "NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac" Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ControllerMpd::pushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::servicePushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: 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":"Dream Racer I","artist":"George Yanagi & Nadja Band","album":"Matsuribayashi ga Kikoeru","uri":"NAS/Roach/jazz/George Yanagi & Nadja Band - Matsuribayashi ga Kikoeru (1977, Bourbon-Japan) [LP 24-192]/01 - Dream Racer I.flac","trackType":"flac"} Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: CURRENT POSITION 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState stateService stop Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState currentStatus stop Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: No code Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.736+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=0 volume=41 Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.737+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac" title="Skip Step" Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.737+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=0 volume=41 Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.737+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac" title="Skip Step" Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.737+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=0 volume=41 Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.737+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac" title="Skip Step" Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ------------------------------ 27ms Apr 13 21:25:24 volumio-pisya volumio[1219]: error: updateQueue error: null Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Apr 13 21:25:24 volumio-pisya volumio[1219]: ---------------------------- MPD announces system playlist update Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Ignoring MPD Status Update Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ------------------------------ 16ms Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand add "NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac" took 14 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand play Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ------------------------------ 10ms Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand play took 9 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Apr 13 21:25:24 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ControllerMpd::getState Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Apr 13 21:25:24 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand status took 6 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ControllerMpd::getState Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseState Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand status took 2 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseState Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ControllerMpd::pushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::servicePushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":468,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Skip Step","artist":"Hiromasa Suzuki","album":"Skip Step Colgen","uri":"NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac","trackType":"flac"} Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: CURRENT POSITION 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState stateService play Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState currentStatus stop Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ------------------------------ 9ms Apr 13 21:25:24 volumio-pisya volumio[1219]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ControllerMpd::pushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::servicePushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1215,"duration":468,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"372 Kbps","isStreaming":false,"title":"Skip Step","artist":"Hiromasa Suzuki","album":"Skip Step Colgen","uri":"NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac","trackType":"flac"} Apr 13 21:25:24 volumio-pisya volumio[1219]: verbose: CURRENT POSITION 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState stateService play Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState currentStatus play Apr 13 21:25:24 volumio-pisya volumio[1219]: info: Received an update from plugin. extracting info from payload Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:25:24 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:24 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.889+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_PLAYING positionMs=1215 volume=41 Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.890+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac" title="Skip Step" Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.890+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_PLAYING positionMs=1215 volume=41 Apr 13 21:25:24 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:25:24.891+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac" title="Skip Step" Apr 13 21:25:24 volumio-pisya volumio[1219]: info: ------------------------------ 19ms Apr 13 21:25:27 volumio-pisya volumio[1219]: info: Tunnel connection is inactive, restarting it Apr 13 21:25:27 volumio-pisya volumio[1219]: info: Starting Tunnel 1 Apr 13 21:25:27 volumio-pisya volumio[1219]: info: Starting Tunnel Connection Checker Apr 13 21:25:27 volumio-pisya sudo[3692]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 13 21:25:27 volumio-pisya sudo[3692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 13 21:25:27 volumio-pisya autossh[3195]: received signal to exit (15) Apr 13 21:25:27 volumio-pisya systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... Apr 13 21:25:27 volumio-pisya systemd[1]: sshtunnel.service: Deactivated successfully. Apr 13 21:25:27 volumio-pisya systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Apr 13 21:25:27 volumio-pisya systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Apr 13 21:25:27 volumio-pisya sudo[3692]: pam_unix(sudo:session): session closed for user root Apr 13 21:25:27 volumio-pisya volumio[1219]: info: Remote SSH Started Apr 13 21:25:27 volumio-pisya autossh[3695]: port set to 0, monitoring disabled Apr 13 21:25:27 volumio-pisya autossh[3695]: starting ssh (count 1) Apr 13 21:25:27 volumio-pisya autossh[3695]: ssh child pid is 3698 Apr 13 21:25:27 volumio-pisya volumio[1219]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 13 21:25:27 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:27 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:28 volumio-pisya volumiossh-tunnel[3698]: Warning: Permanently added '[eu6.myvolumio.org]:2222' (RSA) to the list of known hosts. Apr 13 21:25:28 volumio-pisya volumiossh-tunnel[3698]: Warning: remote port forwarding failed for listen port 8091 Apr 13 21:25:39 volumio-pisya bluealsa[1005]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_6E_88_88_69_BF_80, ...) Apr 13 21:25:42 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:25:42 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:25:44 volumio-pisya volumio[1219]: info: Executing endpoint metavolumio Apr 13 21:25:44 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 13 21:25:44 volumio-pisya volumio[1219]: info: Executing endpoint metavolumio Apr 13 21:25:44 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 13 21:25:44 volumio-pisya volumio[1219]: info: Executing endpoint metavolumio Apr 13 21:25:44 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 13 21:25:59 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 13 21:25:59 volumio-pisya volumio[1219]: info: CURURI: music-library/NAS/Roach/ambient Apr 13 21:25:59 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:26:07 volumio-pisya bluealsa[1005]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_7B_96_C5_5A_12_2D, ...) Apr 13 21:26:07 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 13 21:26:07 volumio-pisya volumio[1219]: info: CURURI: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96] Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Preloading song: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Preloading song: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/02 - A Street Scene.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Preloading song: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/03 - Absent Friend.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Preloading song: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/04 - Big Shot.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Preloading song: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/05 - Fingerspit.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Preloading song: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/06 - Eyes & Smiles.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Preloading song: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/07 - Pendulum Man.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac in service mpd Apr 13 21:26:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Bark%20Psychosis/Hex/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fambient%2FBark%20Psychosis%20-%20Hex%20(1994)%20%5BFLAC%2024.96%5D%2F01%20-%20The%20Loom.flac&metadata=false Apr 13 21:26:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/02 - A Street Scene.flac in service mpd Apr 13 21:26:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Bark%20Psychosis/Hex/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fambient%2FBark%20Psychosis%20-%20Hex%20(1994)%20%5BFLAC%2024.96%5D%2F02%20-%20A%20Street%20Scene.flac&metadata=false Apr 13 21:26:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/02 - A Street Scene.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/03 - Absent Friend.flac in service mpd Apr 13 21:26:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Bark%20Psychosis/Hex/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fambient%2FBark%20Psychosis%20-%20Hex%20(1994)%20%5BFLAC%2024.96%5D%2F03%20-%20Absent%20Friend.flac&metadata=false Apr 13 21:26:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/03 - Absent Friend.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/04 - Big Shot.flac in service mpd Apr 13 21:26:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Bark%20Psychosis/Hex/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fambient%2FBark%20Psychosis%20-%20Hex%20(1994)%20%5BFLAC%2024.96%5D%2F04%20-%20Big%20Shot.flac&metadata=false Apr 13 21:26:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/04 - Big Shot.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/05 - Fingerspit.flac in service mpd Apr 13 21:26:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Bark%20Psychosis/Hex/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fambient%2FBark%20Psychosis%20-%20Hex%20(1994)%20%5BFLAC%2024.96%5D%2F05%20-%20Fingerspit.flac&metadata=false Apr 13 21:26:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/05 - Fingerspit.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/06 - Eyes & Smiles.flac in service mpd Apr 13 21:26:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Bark%20Psychosis/Hex/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fambient%2FBark%20Psychosis%20-%20Hex%20(1994)%20%5BFLAC%2024.96%5D%2F06%20-%20Eyes%20%26%20Smiles.flac&metadata=false Apr 13 21:26:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/06 - Eyes & Smiles.flac Apr 13 21:26:07 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/07 - Pendulum Man.flac in service mpd Apr 13 21:26:07 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=Bark%20Psychosis/Hex/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Fambient%2FBark%20Psychosis%20-%20Hex%20(1994)%20%5BFLAC%2024.96%5D%2F07%20-%20Pendulum%20Man.flac&metadata=false Apr 13 21:26:07 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/07 - Pendulum Man.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::ClearQueue Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::stop Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::stPlaybackTimer Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::updateTrackBlock Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrackBlock Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:26:13 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::serviceStop Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::serviceStop Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ControllerMpd::stop Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::clearPlayQueue Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::saveQueue Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushQueue Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::addQueueItems Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::addQueueItems Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Using cached record of: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac Apr 13 21:26:13 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:26:13.552+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=0 volume=41 Apr 13 21:26:13 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:26:13.553+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/jazz/Hiromasa Suzuki - Skip Step Colgen (1977, Toshiba-Japan) [LP]/01 - Skip Step.flac" title="Skip Step" Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushQueue Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::saveQueue Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::updateTrackBlock Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrackBlock Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPlay Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::play index 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::addQueueItems Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::addQueueItems Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/02 - A Street Scene.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Using cached record of: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/02 - A Street Scene.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/03 - Absent Friend.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Using cached record of: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/03 - Absent Friend.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/04 - Big Shot.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Using cached record of: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/04 - Big Shot.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/05 - Fingerspit.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Using cached record of: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/05 - Fingerspit.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/06 - Eyes & Smiles.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Using cached record of: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/06 - Eyes & Smiles.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/07 - Pendulum Man.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Using cached record of: music-library/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/07 - Pendulum Man.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::stop Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushQueue Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::saveQueue Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::play index undefined Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::updateTrackBlock Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrackBlock Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::startPlaybackTimer Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::clearAddPlayTracks NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Apr 13 21:26:13 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand stop took 37 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ControllerMpd::getState Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand stop took 25 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand clear Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Apr 13 21:26:13 volumio-pisya volumio[1219]: ---------------------------- MPD announces system playlist update Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Ignoring MPD Status Update Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand status took 1 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand clear took 1 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseState Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand add "NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac" Apr 13 21:26:13 volumio-pisya volumio[1219]: error: updateQueue error: null Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Apr 13 21:26:13 volumio-pisya volumio[1219]: ---------------------------- MPD announces system playlist update Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Ignoring MPD Status Update Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ------------------------------ 2ms Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand add "NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac" took 1 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand play Apr 13 21:26:13 volumio-pisya volumio[1219]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ------------------------------ 4ms Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ------------------------------ 1ms Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand play took 3 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Apr 13 21:26:13 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ControllerMpd::getState Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Apr 13 21:26:13 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand status took 2 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ControllerMpd::getState Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand status Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseState Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand status took 1 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand playlistinfo took 0 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseState Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ControllerMpd::pushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::servicePushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Loom","artist":"Bark Psychosis","album":"Hex","uri":"NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac","trackType":"flac"} Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: CURRENT POSITION 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState stateService play Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState currentStatus stop Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ------------------------------ 4ms Apr 13 21:26:13 volumio-pisya volumio[1219]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: ControllerMpd::parseTrackInfo Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ControllerMpd::pushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::servicePushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Loom","artist":"Bark Psychosis","album":"Hex","uri":"NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac","trackType":"flac"} Apr 13 21:26:13 volumio-pisya volumio[1219]: verbose: CURRENT POSITION 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState stateService play Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::syncState currentStatus play Apr 13 21:26:13 volumio-pisya volumio[1219]: info: Received an update from plugin. extracting info from payload Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:26:13 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:26:13 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:26:13 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:13 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:26:13.810+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_PLAYING positionMs=0 volume=41 Apr 13 21:26:13 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:26:13.810+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_PLAYING positionMs=0 volume=41 Apr 13 21:26:13 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:26:13.811+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac" title="The Loom" Apr 13 21:26:13 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:26:13.811+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac" title="The Loom" Apr 13 21:26:13 volumio-pisya volumio[1219]: info: ------------------------------ 13ms Apr 13 21:26:35 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 13 21:26:35 volumio-pisya volumio[1219]: info: CURURI: music-library/NAS/Roach/electronic Apr 13 21:26:35 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:26:38 volumio-pisya systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Apr 13 21:26:40 volumio-pisya systemd[1]: setdatetime-helper.service: Deactivated successfully. Apr 13 21:26:40 volumio-pisya systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Apr 13 21:26:44 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 13 21:26:44 volumio-pisya volumio[1219]: info: CURURI: music-library/NAS/Roach/electronic/Маяк - Река (2015) Apr 13 21:26:44 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:26:52 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreStateMachine::ClearQueue Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreStateMachine::stop Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreStateMachine::stPlaybackTimer Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreStateMachine::updateTrackBlock Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrackBlock Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreStateMachine::pushState Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushState Apr 13 21:26:52 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output update for this device Apr 13 21:26:52 volumio-pisya volumio[1219]: info: MRS: Pushing multiroomSync output Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioGetState Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreStateMachine::serviceStop Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CorePlayQueue::getTrack 0 Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreCommandRouter::serviceStop Apr 13 21:26:52 volumio-pisya volumio[1219]: info: ControllerMpd::stop Apr 13 21:26:52 volumio-pisya volumio[1219]: verbose: ControllerMpd::sendMpdCommand stop Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CorePlayQueue::clearPlayQueue Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CorePlayQueue::saveQueue Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreCommandRouter::volumioPushQueue Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CoreStateMachine::addQueueItems Apr 13 21:26:52 volumio-pisya volumio[1219]: info: CorePlayQueue::addQueueItems Apr 13 21:26:52 volumio-pisya volumio[1219]: info: Preload queue cleared Apr 13 21:26:52 volumio-pisya volumio[1219]: info: Adding Item to queue: music-library/NAS/Roach/electronic/Маяк - Река (2015) Apr 13 21:26:52 volumio-pisya volumio[1219]: info: Exploding uri music-library/NAS/Roach/electronic/Маяк - Река (2015) in service mpd Apr 13 21:26:52 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:26:52.232+03:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" state=STATUS_STOPPED positionMs=0 volume=41 Apr 13 21:26:52 volumio-pisya volumio5-onboarding[1587]: time=2026-04-13T21:26:52.232+03:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.45:62311 @ 0x30000c0" id="mnt/NAS/Roach/ambient/Bark Psychosis - Hex (1994) [FLAC 24.96]/01 - The Loom.flac" title="The Loom" Apr 13 21:26:52 volumio-pisya volumio[1219]: info: sendMpdCommand stop took 52 milliseconds Apr 13 21:26:52 volumio-pisya volumio[1219]: info: Apr 13 21:26:52 volumio-pisya volumio[1219]: ---------------------------- MPD announces state update: player Apr 13 21:26:52 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=%D0%9C%D0%B0%D1%8F%D0%BA%20-%20%D0%A0%D0%B5%D0%BA%D0%B0/%D0%9C%D0%B0%D1%8F%D0%BA%20-%20%D0%A0%D0%B5%D0%BA%D0%B0/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Felectronic%2F%D0%9C%D0%B0%D1%8F%D0%BA%20-%20%D0%A0%D0%B5%D0%BA%D0%B0%20(2015)%2F%D0%9C%D0%B0%D1%8F%D0%BA%20-%20%D0%A0%D0%B5%D0%BA%D0%B0%20-%20MIR%20100406.cue&metadata=false Apr 13 21:26:52 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/electronic/Маяк - Река (2015)/Маяк - Река - MIR 100406.cue Apr 13 21:26:52 volumio-pisya volumio[1219]: info: ALBUMART /albumart?cacheid=304&web=%D0%9C%D0%B0%D1%8F%D0%BA%20-%20%D0%A0%D0%B5%D0%BA%D0%B0/%D0%9C%D0%B0%D1%8F%D0%BA%20-%20%D0%A0%D0%B5%D0%BA%D0%B0/extralarge&path=%2Fmnt%2FNAS%2FRoach%2Felectronic%2F%D0%9C%D0%B0%D1%8F%D0%BA%20-%20%D0%A0%D0%B5%D0%BA%D0%B0%20(2015)%2F%D0%9C%D0%B0%D1%8F%D0%BA%20-%20%D0%A0%D0%B5%D0%BA%D0%B0%20-%20MIR%20100406.cue&metadata=false Apr 13 21:26:52 volumio-pisya volumio[1219]: info: URI /mnt/NAS/Roach/electronic/Маяк - Река (2015)/Маяк - Река - MIR 100406.cue Apr 13 21:26:52 volumio-pisya volumio[1219]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 21:26:52 volumio-pisya volumio[1219]: Error: Unable to resolve or reject the same promise twice Apr 13 21:26:52 volumio-pisya volumio[1219]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 13 21:26:52 volumio-pisya volumio[1219]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Apr 13 21:26:52 volumio-pisya volumio[1219]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 13 21:26:52 volumio-pisya volumio[1219]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 13 21:26:52 volumio-pisya volumio[1219]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 13 21:26:52 volumio-pisya volumio[1219]: at Socket.emit (node:events:514:28) Apr 13 21:26:52 volumio-pisya volumio[1219]: at addChunk (node:internal/streams/readable:343:12) Apr 13 21:26:52 volumio-pisya volumio[1219]: at readableAddChunk (node:internal/streams/readable:312:11) Apr 13 21:26:52 volumio-pisya volumio[1219]: at Readable.push (node:internal/streams/readable:253:10) Apr 13 21:26:52 volumio-pisya volumio[1219]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Apr 13 21:26:52 volumio-pisya volumio[1219]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 21:26:52 volumio-pisya sudo[3872]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-13 21:25' Apr 13 21:26:52 volumio-pisya sudo[3872]: 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"