Feb 26 03:45:01 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 26 03:45:01 room volumio[1239]: info: READ Feb 26 03:45:01 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:12 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 26 03:45:13 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:16 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:16 room volumio[1239]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::ClearQueue Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::stop Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:16 room volumio[1239]: info: CorePlayQueue::clearPlayQueue Feb 26 03:45:16 room volumio[1239]: info: CorePlayQueue::saveQueue Feb 26 03:45:16 room volumio[1239]: info: CoreCommandRouter::volumioPushQueue Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::addQueueItems Feb 26 03:45:16 room volumio[1239]: info: CorePlayQueue::addQueueItems Feb 26 03:45:16 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:16 room volumio[1239]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99426190 Feb 26 03:45:16 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 26 03:45:16 room volumio[1239]: info: CoreCommandRouter::volumioPushQueue Feb 26 03:45:16 room volumio[1239]: info: CorePlayQueue::saveQueue Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::updateTrackBlock Feb 26 03:45:16 room volumio[1239]: info: CorePlayQueue::getTrackBlock Feb 26 03:45:16 room volumio[1239]: info: CoreCommandRouter::volumioPlay Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::play index 0 Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::stop Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::play index undefined Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:16 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:16 room volumio[1239]: info: CoreStateMachine::startPlaybackTimer Feb 26 03:45:16 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:16 room volumio[1239]: info: [1772045116671] ControllerWebradio::clearAddPlayTrack Feb 26 03:45:16 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 03:45:16 room volumio[1239]: info: sendMpdCommand stop took 5 milliseconds Feb 26 03:45:16 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand clear Feb 26 03:45:16 room volumio[1239]: info: Feb 26 03:45:16 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:16 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:16 room volumio[1239]: info: sendMpdCommand clear took 2 milliseconds Feb 26 03:45:16 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99426190" Feb 26 03:45:16 room volumio[1239]: error: updateQueue error: null Feb 26 03:45:16 room volumio[1239]: info: ------------------------------ 3ms Feb 26 03:45:17 room volumio[1239]: info: Feb 26 03:45:17 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:17 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:17 room volumio[1239]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99426190" took 538 milliseconds Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand play Feb 26 03:45:17 room volumio[1239]: info: ------------------------------ 3ms Feb 26 03:45:17 room volumio[1239]: info: sendMpdCommand play took 2 milliseconds Feb 26 03:45:17 room volumio[1239]: info: Feb 26 03:45:17 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:45:17 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:45:17 room volumio[1239]: info: Feb 26 03:45:17 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:45:17 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:45:17 room volumio[1239]: error: MPD returned error for command status: Failed to decode "http://162.252.171.80:8002/stream"; Failed to connect to 162.252.171.80 port 8002 after 214 ms: Couldn't connect to server: Couldn't connect to server Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 03:45:17 room volumio[1239]: info: sendMpdCommand status took 19 milliseconds Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:45:17 room volumio[1239]: error: MPD returned error for command status: Failed to decode "http://162.252.171.80:8002/stream"; Failed to connect to 162.252.171.80 port 8002 after 214 ms: Couldn't connect to server: Couldn't connect to server Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand clearerror Feb 26 03:45:17 room volumio[1239]: info: sendMpdCommand status took 30 milliseconds Feb 26 03:45:17 room volumio[1239]: info: sendMpdCommand clearerror took 12 milliseconds Feb 26 03:45:17 room volumio[1239]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:45:17 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:45:17 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:17 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:45:17 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:17 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:17 room volumio[1239]: 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":"stream","artist":"(#1 - 301/1000) BEST SMOOTH JAZZ - UK (LONDON) HOST ROD LUCAS","album":null,"uri":"http://162.252.171.80:8002/stream","trackType":""} Feb 26 03:45:17 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::syncState stateService stop Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::syncState currentStatus stop Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:17 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:17 room volumio[1239]: info: No code Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:17 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:17 room volumio5-onboarding[1609]: time=2026-02-26T03:45:17.507+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55536 @ 0x2800840" state=STATUS_UNSPECIFIED positionMs=751 volume=25 Feb 26 03:45:17 room volumio5-onboarding[1609]: time=2026-02-26T03:45:17.507+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55536 @ 0x2800840" id= title= Feb 26 03:45:17 room volumio5-onboarding[1609]: time=2026-02-26T03:45:17.509+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55536 @ 0x2800840" state=STATUS_UNSPECIFIED positionMs=751 volume=25 Feb 26 03:45:17 room volumio5-onboarding[1609]: time=2026-02-26T03:45:17.509+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55536 @ 0x2800840" id= title= Feb 26 03:45:17 room volumio5-onboarding[1609]: time=2026-02-26T03:45:17.511+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55536 @ 0x2800840" state=STATUS_UNSPECIFIED positionMs=751 volume=25 Feb 26 03:45:17 room volumio5-onboarding[1609]: time=2026-02-26T03:45:17.511+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55536 @ 0x2800840" id= title= Feb 26 03:45:17 room volumio5-onboarding[1609]: time=2026-02-26T03:45:17.525+09:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.25:55536 Feb 26 03:45:17 room volumio5-onboarding[1609]: time=2026-02-26T03:45:17.526+09:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.25:55536 Feb 26 03:45:17 room volumio[1239]: info: ------------------------------ 94ms Feb 26 03:45:17 room volumio5-onboarding[1609]: time=2026-02-26T03:45:17.535+09:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.25:55672 Feb 26 03:45:17 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status Feb 26 03:45:17 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status undefined Feb 26 03:45:17 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status undefined Feb 26 03:45:17 room volumio[1239]: info: sendMpdCommand clearerror took 99 milliseconds Feb 26 03:45:17 room volumio[1239]: info: sendMpdCommand playlistinfo took 97 milliseconds Feb 26 03:45:17 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:45:17 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:45:17 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:17 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:17 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:17 room volumio[1239]: 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":"stream","artist":"(#1 - 301/1000) BEST SMOOTH JAZZ - UK (LONDON) HOST ROD LUCAS","album":null,"uri":"http://162.252.171.80:8002/stream","trackType":""} Feb 26 03:45:17 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::syncState stateService stop Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::syncState currentStatus stop Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:17 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:17 room volumio[1239]: info: No code Feb 26 03:45:17 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:17 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:17 room volumio[1239]: info: ------------------------------ 177ms Feb 26 03:45:17 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status undefined Feb 26 03:45:17 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status undefined Feb 26 03:45:17 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status undefined Feb 26 03:45:23 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::ClearQueue Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::stop Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::clearPlayQueue Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::saveQueue Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::volumioPushQueue Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::addQueueItems Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::addQueueItems Feb 26 03:45:23 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:23 room volumio[1239]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99536742 Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::volumioPushQueue Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::saveQueue Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::updateTrackBlock Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::getTrackBlock Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::volumioPlay Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::play index 0 Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::stop Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::play index undefined Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::startPlaybackTimer Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:23 room volumio[1239]: info: [1772045123138] ControllerWebradio::clearAddPlayTrack Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 03:45:23 room volumio[1239]: info: sendMpdCommand stop took 7 milliseconds Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand clear Feb 26 03:45:23 room volumio[1239]: info: Feb 26 03:45:23 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:23 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:23 room volumio[1239]: info: sendMpdCommand clear took 1 milliseconds Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99536742" Feb 26 03:45:23 room volumio[1239]: error: updateQueue error: null Feb 26 03:45:23 room volumio[1239]: info: ------------------------------ 3ms Feb 26 03:45:23 room volumio[1239]: info: Feb 26 03:45:23 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:23 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:23 room volumio[1239]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99536742" took 210 milliseconds Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand play Feb 26 03:45:23 room volumio[1239]: info: ------------------------------ 2ms Feb 26 03:45:23 room volumio[1239]: info: sendMpdCommand play took 2 milliseconds Feb 26 03:45:23 room volumio[1239]: info: Feb 26 03:45:23 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:45:23 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:45:23 room volumio[1239]: info: Feb 26 03:45:23 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:45:23 room volumio[1239]: info: sendMpdCommand status took 44 milliseconds Feb 26 03:45:23 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:45:23 room volumio[1239]: info: sendMpdCommand status took 2 milliseconds Feb 26 03:45:23 room volumio[1239]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:45:23 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:23 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 200/1000) Smooth Jazz Florida Worldwide","album":null,"uri":"http://server.webnetradio.net:5120/stream","trackType":""} Feb 26 03:45:23 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::syncState currentStatus stop Feb 26 03:45:23 room volumio[1239]: info: ------------------------------ 48ms Feb 26 03:45:23 room volumio[1239]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 26 03:45:23 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:45:23 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:23 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 200/1000) Smooth Jazz Florida Worldwide","album":null,"uri":"http://server.webnetradio.net:5120/stream","trackType":""} Feb 26 03:45:23 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::syncState currentStatus play Feb 26 03:45:23 room volumio[1239]: info: Received an update from plugin. extracting info from payload Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:23 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:23 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:23 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:23 room volumio5-onboarding[1609]: time=2026-02-26T03:45:23.906+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=208 volume=25 Feb 26 03:45:23 room volumio5-onboarding[1609]: time=2026-02-26T03:45:23.906+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id=http://server.webnetradio.net:5120/stream title="Smooth Jazz Florida Worldwide" Feb 26 03:45:23 room volumio5-onboarding[1609]: time=2026-02-26T03:45:23.908+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=208 volume=25 Feb 26 03:45:23 room volumio5-onboarding[1609]: time=2026-02-26T03:45:23.909+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id=http://server.webnetradio.net:5120/stream title="Smooth Jazz Florida Worldwide" Feb 26 03:45:23 room volumio[1239]: info: ------------------------------ 32ms Feb 26 03:45:23 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:45:23 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:45:23 room sudo[5449]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:45:23 room sudo[5449]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:23 room sudo[5451]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:45:23 room sudo[5451]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:24 room volumio[1239]: info: Feb 26 03:45:24 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:24 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:24 room volumio[1239]: info: Feb 26 03:45:24 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:45:24 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:45:24 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:45:24 room systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 26 03:45:24 room volumio[1239]: info: ------------------------------ 8ms Feb 26 03:45:24 room volumio[1239]: info: sendMpdCommand status took 8 milliseconds Feb 26 03:45:24 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:45:24 room sudo[5449]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:24 room sudo[5451]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:24 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:45:24 room volumio[1239]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 26 03:45:24 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:45:24 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:45:24 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:45:24 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:24 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":879,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Matt Willard - Oh Baby Baby","artist":"Smooth Jazz Florida Worldwide","album":null,"uri":"http://server.webnetradio.net:5120/stream","trackType":""} Feb 26 03:45:24 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:45:24 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:45:24 room volumio[1239]: info: CoreStateMachine::syncState currentStatus play Feb 26 03:45:24 room volumio[1239]: info: Received an update from plugin. extracting info from payload Feb 26 03:45:24 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 26 03:45:24 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:24 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:45:24 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:24 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:24 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:24 room volumio5-onboarding[1609]: time=2026-02-26T03:45:24.106+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=269 volume=25 Feb 26 03:45:24 room volumio5-onboarding[1609]: time=2026-02-26T03:45:24.107+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id=http://server.webnetradio.net:5120/stream title="Matt Willard - Oh Baby Baby" Feb 26 03:45:24 room volumio5-onboarding[1609]: time=2026-02-26T03:45:24.108+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=269 volume=25 Feb 26 03:45:24 room volumio5-onboarding[1609]: time=2026-02-26T03:45:24.109+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id=http://server.webnetradio.net:5120/stream title="Matt Willard - Oh Baby Baby" Feb 26 03:45:24 room volumio[1239]: info: ------------------------------ 65ms Feb 26 03:45:24 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:45:24 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:45:24 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:45:24 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:45:24 room sudo[5459]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:45:24 room sudo[5459]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:24 room sudo[5457]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:45:24 room sudo[5457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:24 room sudo[5457]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:24 room sudo[5459]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:24 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:45:24 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:45:25 room systemd[1]: peppyspectrum.service: Deactivated successfully. Feb 26 03:45:38 room volumio[1239]: Searching all installed plugins Feb 26 03:45:38 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 03:45:38 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: , search Feb 26 03:45:38 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 26 03:45:38 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 26 03:45:38 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Feb 26 03:45:38 room volumio[1239]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Feb 26 03:45:38 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 26 03:45:38 room volumio[1239]: info: All search sources collected, pushing search results Feb 26 03:45:39 room volumio[1239]: Searching all installed plugins Feb 26 03:45:39 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 03:45:39 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: , search Feb 26 03:45:39 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 26 03:45:39 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 26 03:45:39 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Feb 26 03:45:39 room volumio[1239]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Feb 26 03:45:39 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 26 03:45:39 room volumio[1239]: info: All search sources collected, pushing search results Feb 26 03:45:41 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::ClearQueue Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::stop Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::stPlaybackTimer Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::updateTrackBlock Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::getTrackBlock Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::serviceStop Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::serviceStop Feb 26 03:45:41 room volumio[1239]: info: [1772045141524] ControllerWebradio::stop Feb 26 03:45:41 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::clearPlayQueue Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::saveQueue Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::volumioPushQueue Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::addQueueItems Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::addQueueItems Feb 26 03:45:41 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:41 room volumio[1239]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s132816 Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 26 03:45:41 room volumio5-onboarding[1609]: time=2026-02-26T03:45:41.533+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_STOPPED positionMs=0 volume=25 Feb 26 03:45:41 room volumio5-onboarding[1609]: time=2026-02-26T03:45:41.533+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99536742" title="Smooth Jazz Florida Worldwide" Feb 26 03:45:41 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status stop Feb 26 03:45:41 room volumio[1239]: info: Feb 26 03:45:41 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:45:41 room volumio[1239]: info: sendMpdCommand stop took 57 milliseconds Feb 26 03:45:41 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:45:41 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:45:41 room volumio[1239]: info: sendMpdCommand status took 3 milliseconds Feb 26 03:45:41 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:45:41 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:45:41 room sudo[5494]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Feb 26 03:45:41 room sudo[5494]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:41 room volumio[1239]: info: sendMpdCommand playlistinfo took 21 milliseconds Feb 26 03:45:41 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:45:41 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:41 room volumio[1239]: 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":"Matt Willard - Oh Baby Baby","artist":"Smooth Jazz Florida Worldwide","album":null,"uri":"http://server.webnetradio.net:5120/stream","trackType":""} Feb 26 03:45:41 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::syncState stateService stop Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::syncState currentStatus stop Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:41 room volumio[1239]: info: No code Feb 26 03:45:41 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:41 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:41 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:41 room volumio5-onboarding[1609]: time=2026-02-26T03:45:41.629+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_STOPPED positionMs=0 volume=25 Feb 26 03:45:41 room volumio5-onboarding[1609]: time=2026-02-26T03:45:41.629+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id= title= Feb 26 03:45:41 room volumio5-onboarding[1609]: time=2026-02-26T03:45:41.630+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_STOPPED positionMs=0 volume=25 Feb 26 03:45:41 room volumio5-onboarding[1609]: time=2026-02-26T03:45:41.631+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id= title= Feb 26 03:45:41 room volumio5-onboarding[1609]: time=2026-02-26T03:45:41.637+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_STOPPED positionMs=0 volume=25 Feb 26 03:45:41 room volumio5-onboarding[1609]: time=2026-02-26T03:45:41.646+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id= title= Feb 26 03:45:41 room sudo[5494]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:41 room volumio[1239]: info: ------------------------------ 109ms Feb 26 03:45:41 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status stop Feb 26 03:45:41 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status stop Feb 26 03:45:41 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status stop Feb 26 03:45:41 room sudo[5500]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Feb 26 03:45:41 room sudo[5500]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:41 room sudo[5504]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Feb 26 03:45:41 room sudo[5504]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:41 room volumio[1239]: info: peppyspectrum Daemon Stop Feb 26 03:45:41 room volumio[1239]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 26 03:45:41 room sudo[5502]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Feb 26 03:45:41 room sudo[5502]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:41 room sudo[5500]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:41 room volumio[1239]: info: peppyspectrum Daemon Stop Feb 26 03:45:41 room sudo[5502]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:41 room sudo[5504]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:41 room volumio[1239]: info: peppyspectrum Daemon Stop Feb 26 03:45:41 room volumio[1239]: info: peppyspectrum Daemon Stop Feb 26 03:45:42 room volumio[1239]: info: CoreCommandRouter::volumioPushQueue Feb 26 03:45:42 room volumio[1239]: info: CorePlayQueue::saveQueue Feb 26 03:45:42 room volumio[1239]: info: CoreStateMachine::updateTrackBlock Feb 26 03:45:42 room volumio[1239]: info: CorePlayQueue::getTrackBlock Feb 26 03:45:42 room volumio[1239]: info: CoreCommandRouter::volumioPlay Feb 26 03:45:42 room volumio[1239]: info: CoreStateMachine::play index 0 Feb 26 03:45:42 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:42 room volumio[1239]: info: CoreStateMachine::stop Feb 26 03:45:42 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:42 room volumio[1239]: info: CoreStateMachine::play index undefined Feb 26 03:45:42 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:42 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:42 room volumio[1239]: info: CoreStateMachine::startPlaybackTimer Feb 26 03:45:42 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:42 room volumio[1239]: info: [1772045142072] ControllerWebradio::clearAddPlayTrack Feb 26 03:45:42 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 03:45:42 room volumio[1239]: info: sendMpdCommand stop took 4 milliseconds Feb 26 03:45:42 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand clear Feb 26 03:45:42 room volumio[1239]: info: Feb 26 03:45:42 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:42 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:42 room volumio[1239]: info: sendMpdCommand clear took 1 milliseconds Feb 26 03:45:42 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand load "https://tunein-live-b.cdnstream1.com/3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1" Feb 26 03:45:42 room volumio[1239]: error: updateQueue error: null Feb 26 03:45:42 room volumio[1239]: info: ------------------------------ 4ms Feb 26 03:45:44 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand add "https://tunein-live-b.cdnstream1.com/3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1" Feb 26 03:45:44 room volumio[1239]: info: Feb 26 03:45:44 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:44 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:44 room volumio[1239]: info: sendMpdCommand add "https://tunein-live-b.cdnstream1.com/3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1" took 1 milliseconds Feb 26 03:45:44 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 26 03:45:44 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand play Feb 26 03:45:44 room volumio[1239]: info: ------------------------------ 2ms Feb 26 03:45:44 room volumio[1239]: info: sendMpdCommand play took 1 milliseconds Feb 26 03:45:47 room volumio[1239]: info: Feb 26 03:45:47 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:45:47 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:45:47 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:45:47 room volumio[1239]: info: Feb 26 03:45:47 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:47 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:47 room volumio[1239]: info: Feb 26 03:45:47 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:45:47 room volumio[1239]: info: sendMpdCommand status took 42 milliseconds Feb 26 03:45:47 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:45:47 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:45:47 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:45:47 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:45:47 room volumio[1239]: info: ------------------------------ 4ms Feb 26 03:45:47 room volumio[1239]: info: sendMpdCommand status took 3 milliseconds Feb 26 03:45:47 room volumio[1239]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 26 03:45:47 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:45:47 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:45:47 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:45:47 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:45:47 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:45:47 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:47 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1","artist":"CALM RADIO - SOLO PIANO - TuneIn Sampler royalty free","album":null,"uri":"https://tunein-live-b.cdnstream1.com/3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1","trackType":""} Feb 26 03:45:47 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:45:47 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:45:47 room volumio[1239]: info: CoreStateMachine::syncState currentStatus stop Feb 26 03:45:47 room volumio[1239]: info: ------------------------------ 49ms Feb 26 03:45:47 room volumio[1239]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 26 03:45:47 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:45:47 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:45:47 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:45:47 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:47 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1","artist":"CALM RADIO - SOLO PIANO - TuneIn Sampler royalty free","album":null,"uri":"https://tunein-live-b.cdnstream1.com/3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1","trackType":""} Feb 26 03:45:47 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:45:47 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:45:47 room volumio[1239]: info: CoreStateMachine::syncState currentStatus play Feb 26 03:45:47 room volumio[1239]: info: Received an update from plugin. extracting info from payload Feb 26 03:45:47 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:47 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:47 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:45:47 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:47 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:47 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:47 room volumio5-onboarding[1609]: time=2026-02-26T03:45:47.725+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 03:45:47 room volumio5-onboarding[1609]: time=2026-02-26T03:45:47.725+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://tunein-live-b.cdnstream1.com/3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1" title="SOLO PIANO" Feb 26 03:45:47 room volumio5-onboarding[1609]: time=2026-02-26T03:45:47.727+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 03:45:47 room volumio5-onboarding[1609]: time=2026-02-26T03:45:47.727+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://tunein-live-b.cdnstream1.com/3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1" title="SOLO PIANO" Feb 26 03:45:47 room volumio[1239]: info: ------------------------------ 32ms Feb 26 03:45:47 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:45:47 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:45:47 room sudo[5511]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:45:47 room sudo[5511]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:47 room sudo[5513]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:45:47 room sudo[5513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:47 room systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 26 03:45:47 room sudo[5513]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:47 room sudo[5511]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:47 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:45:47 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:45:48 room systemd[1]: peppyspectrum.service: Deactivated successfully. Feb 26 03:45:51 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::ClearQueue Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::stop Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::stPlaybackTimer Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::updateTrackBlock Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrackBlock Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::serviceStop Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::serviceStop Feb 26 03:45:51 room volumio[1239]: info: [1772045151563] ControllerWebradio::stop Feb 26 03:45:51 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::clearPlayQueue Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::saveQueue Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::volumioPushQueue Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::addQueueItems Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::addQueueItems Feb 26 03:45:51 room volumio[1239]: info: Preload queue cleared Feb 26 03:45:51 room volumio[1239]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s310038 Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 26 03:45:51 room volumio5-onboarding[1609]: time=2026-02-26T03:45:51.568+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_STOPPED positionMs=0 volume=25 Feb 26 03:45:51 room volumio5-onboarding[1609]: time=2026-02-26T03:45:51.568+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://tunein-live-b.cdnstream1.com/3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1" title="SOLO PIANO" Feb 26 03:45:51 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status stop Feb 26 03:45:51 room sudo[5534]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Feb 26 03:45:51 room volumio[1239]: info: Feb 26 03:45:51 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:45:51 room volumio[1239]: info: sendMpdCommand stop took 63 milliseconds Feb 26 03:45:51 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:45:51 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:45:51 room sudo[5534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:51 room volumio[1239]: info: sendMpdCommand status took 6 milliseconds Feb 26 03:45:51 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:45:51 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:45:51 room volumio[1239]: info: sendMpdCommand playlistinfo took 27 milliseconds Feb 26 03:45:51 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:45:51 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:51 room volumio[1239]: 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":"3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1","artist":"CALM RADIO - SOLO PIANO - TuneIn Sampler royalty free","album":null,"uri":"https://tunein-live-b.cdnstream1.com/3732_128.mp3?aw_0_1st.skey=1772045141&lat=37.4676&lon=126.62&aw_0_1st.abtest=&aw_0_1st.stationId=s132816&aw_0_1st.premium=false&source=TuneIn&aw_0_1st.platform=tunein&aw_0_1st.genre_id=g5&aw_0_1st.class=music&aw_0_1st.ads_partner_alias=ce.Other&aw_0_azn.planguage=en&aw_0_1st.is_ondemand=false&aw_0_1st.topicId=na&aw_0_1st.affiliateIds=a40075%2ca38725%2ca39100&aw_0_1st.bandId=16&delivery=1","trackType":""} Feb 26 03:45:51 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::syncState stateService stop Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::syncState currentStatus stop Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:51 room volumio[1239]: info: No code Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:45:51 room sudo[5534]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:51 room volumio5-onboarding[1609]: time=2026-02-26T03:45:51.710+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_STOPPED positionMs=0 volume=25 Feb 26 03:45:51 room volumio5-onboarding[1609]: time=2026-02-26T03:45:51.710+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_STOPPED positionMs=0 volume=25 Feb 26 03:45:51 room volumio5-onboarding[1609]: time=2026-02-26T03:45:51.711+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id= title= Feb 26 03:45:51 room volumio5-onboarding[1609]: time=2026-02-26T03:45:51.710+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_STOPPED positionMs=0 volume=25 Feb 26 03:45:51 room volumio5-onboarding[1609]: time=2026-02-26T03:45:51.711+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id= title= Feb 26 03:45:51 room volumio5-onboarding[1609]: time=2026-02-26T03:45:51.712+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id= title= Feb 26 03:45:51 room volumio[1239]: info: ------------------------------ 109ms Feb 26 03:45:51 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status stop Feb 26 03:45:51 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status stop Feb 26 03:45:51 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status stop Feb 26 03:45:51 room sudo[5540]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Feb 26 03:45:51 room sudo[5540]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:51 room sudo[5541]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Feb 26 03:45:51 room sudo[5541]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:51 room volumio[1239]: info: peppyspectrum Daemon Stop Feb 26 03:45:51 room volumio[1239]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 26 03:45:51 room sudo[5545]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Feb 26 03:45:51 room sudo[5545]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:45:51 room sudo[5540]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:51 room volumio[1239]: info: peppyspectrum Daemon Stop Feb 26 03:45:51 room sudo[5541]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:51 room volumio[1239]: info: peppyspectrum Daemon Stop Feb 26 03:45:51 room sudo[5545]: pam_unix(sudo:session): session closed for user root Feb 26 03:45:51 room volumio[1239]: info: peppyspectrum Daemon Stop Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::volumioPushQueue Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::saveQueue Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::updateTrackBlock Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrackBlock Feb 26 03:45:51 room volumio[1239]: info: CoreCommandRouter::volumioPlay Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::play index 0 Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::stop Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::play index undefined Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:51 room volumio[1239]: info: CoreStateMachine::startPlaybackTimer Feb 26 03:45:51 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:45:51 room volumio[1239]: info: [1772045151992] ControllerWebradio::clearAddPlayTrack Feb 26 03:45:51 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand stop Feb 26 03:45:51 room volumio[1239]: info: sendMpdCommand stop took 5 milliseconds Feb 26 03:45:51 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand clear Feb 26 03:45:52 room volumio[1239]: info: Feb 26 03:45:52 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:52 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:52 room volumio[1239]: info: sendMpdCommand clear took 5 milliseconds Feb 26 03:45:52 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand load "https://stream.epic-piano.com/chillout-piano?ref=tunein" Feb 26 03:45:52 room volumio[1239]: error: updateQueue error: null Feb 26 03:45:52 room volumio[1239]: info: ------------------------------ 6ms Feb 26 03:45:58 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand add "https://stream.epic-piano.com/chillout-piano?ref=tunein" Feb 26 03:45:58 room volumio[1239]: info: Feb 26 03:45:58 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:45:58 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:45:58 room volumio[1239]: info: sendMpdCommand add "https://stream.epic-piano.com/chillout-piano?ref=tunein" took 1 milliseconds Feb 26 03:45:58 room volumio[1239]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 26 03:45:58 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand play Feb 26 03:45:58 room volumio[1239]: info: ------------------------------ 2ms Feb 26 03:45:58 room volumio[1239]: info: sendMpdCommand play took 1 milliseconds Feb 26 03:46:00 room volumio[1239]: info: Feb 26 03:46:00 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:46:00 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:46:00 room volumio[1239]: info: sendMpdCommand status took 41 milliseconds Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:46:00 room volumio[1239]: info: Feb 26 03:46:00 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:46:00 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:46:00 room volumio[1239]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:46:00 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:46:00 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:46:00 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chillout-piano?ref=tunein","artist":null,"album":null,"uri":"https://stream.epic-piano.com/chillout-piano?ref=tunein","trackType":""} Feb 26 03:46:00 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::syncState currentStatus stop Feb 26 03:46:00 room volumio[1239]: info: ------------------------------ 45ms Feb 26 03:46:00 room volumio[1239]: info: sendMpdCommand status took 3 milliseconds Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:46:00 room volumio[1239]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:46:00 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:46:00 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:46:00 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"chillout-piano?ref=tunein","artist":null,"album":null,"uri":"https://stream.epic-piano.com/chillout-piano?ref=tunein","trackType":""} Feb 26 03:46:00 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::syncState currentStatus play Feb 26 03:46:00 room volumio[1239]: info: Received an update from plugin. extracting info from payload Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:00 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.429+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.429+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="CHILLOUT PIANO by Epic Piano" Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.430+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=0 volume=25 Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.430+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="CHILLOUT PIANO by Epic Piano" Feb 26 03:46:00 room volumio[1239]: info: ------------------------------ 28ms Feb 26 03:46:00 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:00 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:00 room sudo[5566]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:00 room sudo[5566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:00 room sudo[5568]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:00 room sudo[5568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:00 room systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 26 03:46:00 room sudo[5566]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:00 room sudo[5568]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:00 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:00 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:00 room volumio[1239]: info: Feb 26 03:46:00 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:46:00 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:46:00 room volumio[1239]: info: Feb 26 03:46:00 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:46:00 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:46:00 room volumio[1239]: info: Feb 26 03:46:00 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:46:00 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:46:00 room volumio[1239]: info: Feb 26 03:46:00 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:46:00 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:46:00 room volumio[1239]: info: ------------------------------ 11ms Feb 26 03:46:00 room volumio[1239]: info: sendMpdCommand status took 6 milliseconds Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:46:00 room volumio[1239]: info: ------------------------------ 9ms Feb 26 03:46:00 room volumio[1239]: info: sendMpdCommand status took 6 milliseconds Feb 26 03:46:00 room volumio[1239]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:46:00 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:46:00 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:46:00 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":882,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"waking up","artist":"EP_chillout_piano","album":null,"uri":"https://stream.epic-piano.com/chillout-piano?ref=tunein","trackType":""} Feb 26 03:46:00 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::syncState currentStatus play Feb 26 03:46:00 room volumio[1239]: info: Received an update from plugin. extracting info from payload Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.855+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=505 volume=25 Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.855+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="waking up" Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.857+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=505 volume=25 Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.857+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="waking up" Feb 26 03:46:00 room volumio[1239]: info: ------------------------------ 68ms Feb 26 03:46:00 room volumio[1239]: info: sendMpdCommand playlistinfo took 51 milliseconds Feb 26 03:46:00 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:46:00 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:46:00 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:46:00 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":882,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"waking up","artist":"EP_chillout_piano","album":null,"uri":"https://stream.epic-piano.com/chillout-piano?ref=tunein","trackType":""} Feb 26 03:46:00 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::syncState currentStatus play Feb 26 03:46:00 room volumio[1239]: info: Received an update from plugin. extracting info from payload Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:00 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:00 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.906+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=505 volume=25 Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.907+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="waking up" Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.916+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=505 volume=25 Feb 26 03:46:00 room volumio5-onboarding[1609]: time=2026-02-26T03:46:00.916+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="waking up" Feb 26 03:46:00 room volumio[1239]: info: ------------------------------ 109ms Feb 26 03:46:00 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:00 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:00 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:00 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:00 room sudo[5574]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:00 room sudo[5574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:01 room sudo[5576]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:01 room sudo[5576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:01 room sudo[5578]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:01 room sudo[5578]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:01 room sudo[5574]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:01 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:01 room sudo[5581]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:01 room sudo[5581]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:01 room sudo[5576]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:01 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:01 room sudo[5578]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:01 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:01 room sudo[5581]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:01 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:01 room systemd[1]: peppyspectrum.service: Deactivated successfully. Feb 26 03:46:29 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 26 03:46:29 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 26 03:46:32 room volumio[1239]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 03:46:37 room volumio[1239]: info: Feb 26 03:46:37 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:46:37 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:46:37 room volumio[1239]: info: Feb 26 03:46:37 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:46:37 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:46:37 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:46:37 room volumio[1239]: info: ------------------------------ 1ms Feb 26 03:46:37 room volumio[1239]: info: sendMpdCommand status took 1 milliseconds Feb 26 03:46:37 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:46:37 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:46:37 room volumio[1239]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 26 03:46:37 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:46:37 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:46:37 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:46:37 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:46:37 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":37182,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"chillout-piano?ref=tunein","artist":"EP_chillout_piano","album":null,"uri":"https://stream.epic-piano.com/chillout-piano?ref=tunein","trackType":""} Feb 26 03:46:37 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:46:37 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:46:37 room volumio[1239]: info: CoreStateMachine::syncState currentStatus play Feb 26 03:46:37 room volumio[1239]: info: Received an update from plugin. extracting info from payload Feb 26 03:46:37 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:37 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:46:37 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:46:37 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:37 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:37 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:37 room volumio5-onboarding[1609]: time=2026-02-26T03:46:37.135+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=36829 volume=25 Feb 26 03:46:37 room volumio5-onboarding[1609]: time=2026-02-26T03:46:37.136+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="CHILLOUT PIANO by Epic Piano" Feb 26 03:46:37 room volumio5-onboarding[1609]: time=2026-02-26T03:46:37.136+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=36829 volume=25 Feb 26 03:46:37 room volumio5-onboarding[1609]: time=2026-02-26T03:46:37.136+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="CHILLOUT PIANO by Epic Piano" Feb 26 03:46:37 room volumio[1239]: info: ------------------------------ 30ms Feb 26 03:46:37 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:37 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:37 room sudo[5632]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:37 room sudo[5632]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:37 room sudo[5634]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:37 room sudo[5634]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:37 room systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 26 03:46:37 room sudo[5632]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:37 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:37 room sudo[5634]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:37 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:37 room systemd[1]: peppyspectrum.service: Deactivated successfully. Feb 26 03:46:38 room volumio[1239]: info: Feb 26 03:46:38 room volumio[1239]: ---------------------------- MPD announces system playlist update Feb 26 03:46:38 room volumio[1239]: info: Ignoring MPD Status Update Feb 26 03:46:38 room volumio[1239]: info: Feb 26 03:46:38 room volumio[1239]: ---------------------------- MPD announces state update: player Feb 26 03:46:38 room volumio[1239]: info: ControllerMpd::getState Feb 26 03:46:38 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand status Feb 26 03:46:38 room volumio[1239]: info: ------------------------------ 1ms Feb 26 03:46:38 room volumio[1239]: info: sendMpdCommand status took 1 milliseconds Feb 26 03:46:38 room volumio[1239]: verbose: ControllerMpd::parseState Feb 26 03:46:38 room volumio[1239]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 26 03:46:38 room volumio[1239]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 26 03:46:38 room volumio[1239]: verbose: ControllerMpd::parseTrackInfo Feb 26 03:46:38 room volumio[1239]: info: ControllerMpd::pushState Feb 26 03:46:38 room volumio[1239]: info: CoreCommandRouter::servicePushState Feb 26 03:46:38 room volumio[1239]: info: CorePlayQueue::getTrack 0 Feb 26 03:46:38 room volumio[1239]: verbose: STATE SERVICE {"status":"play","position":0,"seek":38583,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Stephan Beneking,Michael Hauber - Du côte de chez Swann","artist":"EP_chillout_piano","album":null,"uri":"https://stream.epic-piano.com/chillout-piano?ref=tunein","trackType":""} Feb 26 03:46:38 room volumio[1239]: verbose: CURRENT POSITION 0 Feb 26 03:46:38 room volumio[1239]: info: CoreStateMachine::syncState stateService play Feb 26 03:46:38 room volumio[1239]: info: CoreStateMachine::syncState currentStatus play Feb 26 03:46:38 room volumio[1239]: info: Received an update from plugin. extracting info from payload Feb 26 03:46:38 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:38 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 03:46:38 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:38 room volumio[1239]: info: CoreStateMachine::pushState Feb 26 03:46:38 room volumio[1239]: info: CoreCommandRouter::volumioPushState Feb 26 03:46:38 room volumio5-onboarding[1609]: time=2026-02-26T03:46:38.534+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=38079 volume=25 Feb 26 03:46:38 room volumio5-onboarding[1609]: time=2026-02-26T03:46:38.534+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="Stephan Beneking,Michael Hauber - Du côte de chez Swann" Feb 26 03:46:38 room volumio5-onboarding[1609]: time=2026-02-26T03:46:38.534+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" state=STATUS_PLAYING positionMs=38079 volume=25 Feb 26 03:46:38 room volumio5-onboarding[1609]: time=2026-02-26T03:46:38.534+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.25:55672 @ 0x2801350" id="https://stream.epic-piano.com/chillout-piano?ref=tunein" title="Stephan Beneking,Michael Hauber - Du côte de chez Swann" Feb 26 03:46:38 room volumio[1239]: info: ------------------------------ 26ms Feb 26 03:46:38 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:38 room volumio[1239]: info: PeppySpectrum ---peppyspectrum status play Feb 26 03:46:38 room sudo[5641]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:38 room sudo[5641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:38 room sudo[5644]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Feb 26 03:46:38 room sudo[5644]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 03:46:38 room systemd[1]: Started peppyspectrum.service - peppyspectrum Daemon. Feb 26 03:46:38 room sudo[5641]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:38 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:38 room sudo[5644]: pam_unix(sudo:session): session closed for user root Feb 26 03:46:38 room volumio[1239]: info: peppyspectrum Daemon Started Feb 26 03:46:38 room volumio[1239]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object] Feb 26 03:46:38 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy Feb 26 03:46:38 room volumio[1239]: aaaaaaaaaaa Gelo5_1920,480.40skins Feb 26 03:46:38 room volumio[1239]: info: PeppySpectrum ---Gelo5_1920480.40skins Feb 26 03:46:38 room volumio[1239]: info: PeppySpectrum ---NaN480NaN Feb 26 03:46:38 room volumio[1239]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 26 03:46:38 room volumio[1239]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 03:46:38 room volumio[1239]: info: CoreCommandRouter::Close All Modals sent Feb 26 03:46:38 room volumio[1239]: error: Error reading spectrum.txt: Error: ENOENT: no such file or directory, open '/data/INTERNAL/PeppySpectrum/Templates/Gelo5_1920x480.40skins/spectrum.txt' Feb 26 03:46:39 room systemd[1]: peppyspectrum.service: Deactivated successfully. Feb 26 03:46:43 room volumio[1239]: info: CALLMETHOD: user_interface peppyspectrum updatelist Feb 26 03:46:43 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , updatelist Feb 26 03:46:43 room volumio[1239]: info: PeppySpectrum --- wget 'https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt' Feb 26 03:46:44 room volumio[1239]: --2026-02-26 03:46:43-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt Feb 26 03:46:44 room volumio[1239]: Resolving github.com (github.com)... 20.200.245.247 Feb 26 03:46:44 room volumio[1239]: Connecting to github.com (github.com)|20.200.245.247|:443... connected. Feb 26 03:46:44 room volumio[1239]: HTTP request sent, awaiting response... 302 Found Feb 26 03:46:44 room volumio[1239]: Location: https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt [following] Feb 26 03:46:44 room volumio[1239]: --2026-02-26 03:46:44-- https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt Feb 26 03:46:44 room volumio[1239]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.108.133, 185.199.110.133, 185.199.109.133, ... Feb 26 03:46:44 room volumio[1239]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.108.133|:443... connected. Feb 26 03:46:44 room volumio[1239]: HTTP request sent, awaiting response... 200 OK Feb 26 03:46:44 room volumio[1239]: Length: 471 [text/plain] Feb 26 03:46:44 room volumio[1239]: Saving to: ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ Feb 26 03:46:44 room volumio[1239]: 0K 100% 6.91M=0s Feb 26 03:46:44 room volumio[1239]: 2026-02-26 03:46:44 (6.91 MB/s) - ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ saved [471/471] Feb 26 03:46:44 room volumio[1239]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 26 03:46:44 room volumio[1239]: info: CoreCommandRouter::Close All Modals sent Feb 26 03:46:44 room volumio[1239]: error: Error reading spectrum.txt: Error: ENOENT: no such file or directory, open '/data/INTERNAL/PeppySpectrum/Templates/Gelo5_1920x480.40skins/spectrum.txt' Feb 26 03:46:46 room volumio[1239]: info: CALLMETHOD: user_interface peppyspectrum dlspectrum [object Object] Feb 26 03:46:46 room volumio[1239]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , dlspectrum Feb 26 03:46:47 room volumio[1239]: --2026-02-26 03:46:46-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/Zipped-folders/Choose Feb 26 03:46:47 room volumio[1239]: Resolving github.com (github.com)... 20.200.245.247 Feb 26 03:46:47 room volumio[1239]: Connecting to github.com (github.com)|20.200.245.247|:443... connected. Feb 26 03:46:47 room volumio[1239]: HTTP request sent, awaiting response... 404 Not Found Feb 26 03:46:47 room volumio[1239]: 2026-02-26 03:46:46 ERROR 404: Not Found. Feb 26 03:46:47 room volumio[1239]: --2026-02-26 03:46:46-- http://a/ Feb 26 03:46:47 room volumio[1239]: Resolving a (a)... failed: Device or resource busy. Feb 26 03:46:47 room volumio[1239]: wget: unable to resolve host address ‘a’ Feb 26 03:46:47 room volumio[1239]: --2026-02-26 03:46:46-- http://packet.zip/ Feb 26 03:46:47 room volumio[1239]: Resolving packet.zip (packet.zip)... 162.255.119.167 Feb 26 03:46:47 room volumio[1239]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. Feb 26 03:46:47 room volumio[1239]: HTTP request sent, awaiting response... 302 Found Feb 26 03:46:47 room volumio[1239]: Location: http://www.packet.zip/ [following] Feb 26 03:46:47 room volumio[1239]: --2026-02-26 03:46:47-- http://www.packet.zip/ Feb 26 03:46:47 room volumio[1239]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 Feb 26 03:46:47 room volumio[1239]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Feb 26 03:46:47 room volumio[1239]: HTTP request sent, awaiting response... 403 Forbidden Feb 26 03:46:47 room volumio[1239]: 2026-02-26 03:46:47 ERROR 403: Forbidden. Feb 26 03:46:47 room volumio[1239]: error: PeppySpectrum --- An error occurs while downloading or installing Spectrums Feb 26 03:46:47 room volumio[1239]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 26 03:46:47 room volumio[1239]: /bin/rm: cannot remove 'a': No such file or directory Feb 26 03:46:47 room volumio[1239]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 26 03:46:47 room volumio[1239]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 03:46:47 room volumio[1239]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Feb 26 03:46:47 room volumio[1239]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 26 03:46:47 room volumio[1239]: /bin/rm: cannot remove 'a': No such file or directory Feb 26 03:46:47 room volumio[1239]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 26 03:46:47 room volumio[1239]: at checkExecSyncError (node:child_process:887:11) Feb 26 03:46:47 room volumio[1239]: at execSync (node:child_process:959:15) Feb 26 03:46:47 room volumio[1239]: at /data/plugins/user_interface/peppyspectrum/index.js:770:19 Feb 26 03:46:47 room volumio[1239]: at new Promise () Feb 26 03:46:47 room volumio[1239]: at peppyspectrum.dlspectrum (/data/plugins/user_interface/peppyspectrum/index.js:745:12) Feb 26 03:46:47 room volumio[1239]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Feb 26 03:46:47 room volumio[1239]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Feb 26 03:46:47 room volumio[1239]: at Socket.emit (node:events:514:28) Feb 26 03:46:47 room volumio[1239]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 26 03:46:47 room volumio[1239]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Feb 26 03:46:47 room volumio[1239]: status: 1, Feb 26 03:46:47 room volumio[1239]: signal: null, Feb 26 03:46:47 room volumio[1239]: output: [ Feb 26 03:46:47 room volumio[1239]: null, Feb 26 03:46:47 room volumio[1239]: , Feb 26 03:46:47 room volumio[1239]: Feb 26 03:46:47 room volumio[1239]: ], Feb 26 03:46:47 room volumio[1239]: pid: 5670, Feb 26 03:46:47 room volumio[1239]: stdout: , Feb 26 03:46:47 room volumio[1239]: stderr: Feb 26 03:46:47 room volumio[1239]: } Feb 26 03:46:47 room volumio[1239]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 03:46:48 room sudo[5686]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 03:45' Feb 26 03:46:48 room sudo[5686]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"