-- Logs begin at Thu 2019-02-14 19:11:58 +09, end at Wed 2026-03-04 12:09:40 +09. -- Mar 04 12:08:09 volumio-10 volumiologrotate[548]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Mar 04 12:08:09 volumio-10 volumiologrotate[548]: ls: cannot access '10': No such file or directory Mar 04 12:09:09 volumio-10 volumiologrotate[548]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Mar 04 12:09:09 volumio-10 volumiologrotate[548]: ls: cannot access '10': No such file or directory Mar 04 12:09:18 volumio-10 volumio[814]: verbose: New Socket.io Connection to 192.168.0.141 from 192.168.0.174 UA: Mozilla/5.0 (Linux; Android 16; 24031PN0DC Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.120 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetVisibleSources Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetState Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 04 12:09:18 volumio-10 volumio[814]: info: Received Get System Info Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 12:09:18 volumio-10 volumio[814]: info: Discovery: Getting this device information Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetState Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetState Mar 04 12:09:18 volumio-10 volumio[814]: info: Listing playlists Mar 04 12:09:18 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::volumioNext Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::next Mar 04 12:09:19 volumio-10 volumio[814]: info: ControllerMpd::next Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand next Mar 04 12:09:19 volumio-10 volumio[814]: info: sendMpdCommand next took 9 milliseconds Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:19 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:19 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:19 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:19 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:19 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:19 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:19 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:19 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:19 volumio-10 volumio[814]: error: updateQueue error: null Mar 04 12:09:19 volumio-10 volumio[814]: error: updateQueue error: null Mar 04 12:09:19 volumio-10 volumio[814]: error: updateQueue error: null Mar 04 12:09:19 volumio-10 volumio[814]: error: updateQueue error: null Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 4ms Mar 04 12:09:19 volumio-10 volumio[814]: info: sendMpdCommand status took 4 milliseconds Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 4ms Mar 04 12:09:19 volumio-10 volumio[814]: info: sendMpdCommand status took 3 milliseconds Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 3ms Mar 04 12:09:19 volumio-10 volumio[814]: info: sendMpdCommand status took 3 milliseconds Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 2ms Mar 04 12:09:19 volumio-10 volumio[814]: info: sendMpdCommand status took 2 milliseconds Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:19 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 9 Mar 04 12:09:19 volumio-10 volumio[814]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 04 12:09:19 volumio-10 volumio[814]: verbose: CURRENT POSITION 9 Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::syncState stateService stop Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::play index undefined Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:19 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 04 12:09:19 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 04 12:09:19 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.154+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_STOPPED positionMs= volume=41 Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.154+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id=yandex_music/track/146408458:39837251@503646255:153863392 title="COLD WAVES" Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.154+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PAUSED positionMs=223649 volume=41 Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.154+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_STOPPED positionMs= volume=41 Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.155+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-22.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D84079f82220931773d62c99e447b27b84289a46bf4c9a452533417a8cad6c21b%2Clid%3D65%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59da1%2F0%2F770743%2F323429a8.102280536.22.67993726%2Fflac-mp4&ext=.flac" title="Летний вечер" Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.155+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id=yandex_music/track/146408458:39837251@503646255:153863392 title="COLD WAVES" Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.154+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_STOPPED positionMs= volume=41 Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.155+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_STOPPED positionMs= volume=41 Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.155+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id=yandex_music/track/146408458:39837251@503646255:153863392 title="COLD WAVES" Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.155+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id=yandex_music/track/146408458:39837251@503646255:153863392 title="COLD WAVES" Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::startPlaybackTimer Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand stop Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 26ms Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 26ms Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 25ms Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 24ms Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.168+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_STOPPED positionMs=0 volume=41 Mar 04 12:09:19 volumio-10 volumio[814]: error: Upnp client error: Error: This socket has been ended by the other party Mar 04 12:09:19 volumio-10 volumio[814]: info: sendMpdCommand stop took 12 milliseconds Mar 04 12:09:19 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand clear Mar 04 12:09:19 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:19.171+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id=yandex_music/track/146408458:39837251@503646255:153863392 title="COLD WAVES" Mar 04 12:09:19 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status pause Mar 04 12:09:19 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 04 12:09:19 volumio-10 sudo[24240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 04 12:09:19 volumio-10 sudo[24240]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:19 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 04 12:09:19 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 04 12:09:19 volumio-10 sudo[24243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 04 12:09:19 volumio-10 sudo[24240]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:19 volumio-10 sudo[24243]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:19 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 04 12:09:19 volumio-10 sudo[24245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 04 12:09:19 volumio-10 sudo[24245]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:19 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status stop Mar 04 12:09:19 volumio-10 sudo[24256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 04 12:09:19 volumio-10 sudo[24256]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:19 volumio-10 sudo[24259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 04 12:09:19 volumio-10 sudo[24259]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:19 volumio-10 sudo[24243]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:19 volumio-10 sudo[24245]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:19 volumio-10 sudo[24256]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:19 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:19 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:19 volumio-10 sudo[24269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Mar 04 12:09:19 volumio-10 sudo[24269]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:19 volumio-10 sudo[24259]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:19 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:19 volumio-10 volumio[814]: info: sendMpdCommand clear took 247 milliseconds Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:19 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:19 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:19 volumio-10 volumio[814]: info: Mar 04 12:09:19 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:19 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:19 volumio-10 volumio[814]: info: peppymeterbasic Daemon Stop Mar 04 12:09:19 volumio-10 volumio[814]: info: peppymeterbasic Daemon Stop Mar 04 12:09:19 volumio-10 volumio[814]: info: peppymeterbasic Daemon Stop Mar 04 12:09:19 volumio-10 volumio[814]: info: peppymeterbasic Daemon Stop Mar 04 12:09:19 volumio-10 volumio[814]: error: updateQueue error: null Mar 04 12:09:19 volumio-10 volumio[814]: error: updateQueue error: null Mar 04 12:09:19 volumio-10 volumio[814]: error: updateQueue error: null Mar 04 12:09:19 volumio-10 volumio[814]: error: updateQueue error: null Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 20ms Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 10ms Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 9ms Mar 04 12:09:19 volumio-10 volumio[814]: info: ------------------------------ 9ms Mar 04 12:09:19 volumio-10 sudo[24269]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:19 volumio-10 volumio[814]: info: peppymeterbasic Daemon Stop Mar 04 12:09:19 volumio-10 volumio[814]: info: peppymeterbasic Daemon Stop Mar 04 12:09:20 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" Mar 04 12:09:20 volumio-10 volumio[814]: info: Mar 04 12:09:20 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:20 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:20 volumio-10 volumio[814]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" took 3 milliseconds Mar 04 12:09:20 volumio-10 volumio[814]: verbose: MPD COMMAND [object Object] Mar 04 12:09:20 volumio-10 volumio[814]: verbose: MPD COMMAND [object Object] Mar 04 12:09:20 volumio-10 volumio[814]: verbose: MPD COMMAND [object Object] Mar 04 12:09:20 volumio-10 volumio[814]: info: Mar 04 12:09:20 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:20 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:20 volumio-10 volumio[814]: info: Mar 04 12:09:20 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:20 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:20 volumio-10 volumio[814]: info: Mar 04 12:09:20 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:20 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:20 volumio-10 volumio[814]: info: Mar 04 12:09:20 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:20 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:20 volumio-10 volumio[814]: info: ------------------------------ 9ms Mar 04 12:09:20 volumio-10 volumio[814]: info: ------------------------------ 4ms Mar 04 12:09:20 volumio-10 volumio[814]: info: ------------------------------ 2ms Mar 04 12:09:20 volumio-10 volumio[814]: info: ------------------------------ 3ms Mar 04 12:09:20 volumio-10 volumio[814]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 04 12:09:20 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand play Mar 04 12:09:20 volumio-10 volumio[814]: info: Mar 04 12:09:20 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:20 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:20 volumio-10 volumio[814]: info: Mar 04 12:09:20 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:20 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:20 volumio-10 volumio[814]: info: Mar 04 12:09:20 volumio-10 volumio[814]: ---------------------------- MPD announces system playlist update Mar 04 12:09:20 volumio-10 volumio[814]: info: Ignoring MPD Status Update Mar 04 12:09:20 volumio-10 volumio[814]: info: ------------------------------ 4ms Mar 04 12:09:20 volumio-10 volumio[814]: info: sendMpdCommand play took 5 milliseconds Mar 04 12:09:20 volumio-10 volumio[814]: info: ------------------------------ 5ms Mar 04 12:09:20 volumio-10 volumio[814]: info: ------------------------------ 4ms Mar 04 12:09:21 volumio-10 volumio[814]: info: Mar 04 12:09:21 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:21 volumio-10 volumio[814]: info: Mar 04 12:09:21 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:21 volumio-10 volumio[814]: info: Mar 04 12:09:21 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:21 volumio-10 volumio[814]: info: Mar 04 12:09:21 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand status took 94 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand status took 94 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand status took 93 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 12:09:21 volumio-10 volumio[814]: info: Mar 04 12:09:21 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:21 volumio-10 volumio[814]: info: Mar 04 12:09:21 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand status took 94 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:21 volumio-10 volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"COLD WAVES","artist":"NIGYL","album":"COLD WAVES","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac","trackType":"flac"} Mar 04 12:09:21 volumio-10 volumio[814]: verbose: CURRENT POSITION 10 Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState stateService play Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState currentStatus stop Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:21 volumio-10 volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"COLD WAVES","artist":"NIGYL","album":"COLD WAVES","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac","trackType":"flac"} Mar 04 12:09:21 volumio-10 volumio[814]: verbose: CURRENT POSITION 10 Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState stateService play Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 04 12:09:21 volumio-10 volumio[814]: info: Received an update from plugin. extracting info from payload Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:21 volumio-10 volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"COLD WAVES","artist":"NIGYL","album":"COLD WAVES","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac","trackType":"flac"} Mar 04 12:09:21 volumio-10 volumio[814]: verbose: CURRENT POSITION 10 Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState stateService play Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 04 12:09:21 volumio-10 volumio[814]: info: Received an update from plugin. extracting info from payload Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: ------------------------------ 105ms Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.672+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=0 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.673+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.673+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=0 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.673+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.676+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=0 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.676+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.678+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=0 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.679+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio[814]: info: ------------------------------ 116ms Mar 04 12:09:21 volumio-10 volumio[814]: info: ------------------------------ 117ms Mar 04 12:09:21 volumio-10 volumio[814]: info: Mar 04 12:09:21 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:21 volumio-10 volumio[814]: info: Mar 04 12:09:21 volumio-10 volumio[814]: ---------------------------- MPD announces state update: player Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::getState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand status Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand status took 26 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand status took 26 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand playlistinfo took 25 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand status took 3 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand status took 2 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseState Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:21 volumio-10 volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"COLD WAVES","artist":"NIGYL","album":"COLD WAVES","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac","trackType":"flac"} Mar 04 12:09:21 volumio-10 volumio[814]: verbose: CURRENT POSITION 10 Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState stateService play Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 04 12:09:21 volumio-10 volumio[814]: info: Received an update from plugin. extracting info from payload Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.699+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.700+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio[814]: info: ------------------------------ 133ms Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.700+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.701+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:21 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:21 volumio-10 sudo[24280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:21 volumio-10 sudo[24280]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:21 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:21 volumio-10 sudo[24283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:21 volumio-10 sudo[24283]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:21 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:21 volumio-10 sudo[24286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:21 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:21 volumio-10 systemd[1]: Started peppymeterbasic Daemon. Mar 04 12:09:21 volumio-10 sudo[24286]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:21 volumio-10 sudo[24290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:21 volumio-10 sudo[24290]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:21 volumio-10 sudo[24293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:21 volumio-10 sudo[24293]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:21 volumio-10 sudo[24296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:21 volumio-10 sudo[24296]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:21 volumio-10 sudo[24280]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand playlistinfo took 173 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand playlistinfo took 174 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand playlistinfo took 173 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: info: sendMpdCommand playlistinfo took 173 milliseconds Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 04 12:09:21 volumio-10 volumio[814]: verbose: ControllerMpd::parseTrackInfo Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:21 volumio-10 volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"COLD WAVES","artist":"NIGYL","album":"COLD WAVES","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac","trackType":"flac"} Mar 04 12:09:21 volumio-10 volumio[814]: verbose: CURRENT POSITION 10 Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState stateService play Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 04 12:09:21 volumio-10 volumio[814]: info: Received an update from plugin. extracting info from payload Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:21 volumio-10 volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"COLD WAVES","artist":"NIGYL","album":"COLD WAVES","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac","trackType":"flac"} Mar 04 12:09:21 volumio-10 volumio[814]: verbose: CURRENT POSITION 10 Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState stateService play Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 04 12:09:21 volumio-10 volumio[814]: info: Received an update from plugin. extracting info from payload Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:21 volumio-10 volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"COLD WAVES","artist":"NIGYL","album":"COLD WAVES","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac","trackType":"flac"} Mar 04 12:09:21 volumio-10 volumio[814]: verbose: CURRENT POSITION 10 Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState stateService play Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 04 12:09:21 volumio-10 volumio[814]: info: Received an update from plugin. extracting info from payload Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: ControllerMpd::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::servicePushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CorePlayQueue::getTrack 10 Mar 04 12:09:21 volumio-10 volumio[814]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"COLD WAVES","artist":"NIGYL","album":"COLD WAVES","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac","trackType":"flac"} Mar 04 12:09:21 volumio-10 volumio[814]: verbose: CURRENT POSITION 10 Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState stateService play Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::syncState currentStatus play Mar 04 12:09:21 volumio-10 volumio[814]: info: Received an update from plugin. extracting info from payload Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreStateMachine::pushState Mar 04 12:09:21 volumio-10 volumio[814]: info: CoreCommandRouter::volumioPushState Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.881+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.881+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.883+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.883+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.886+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.886+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.886+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.887+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.892+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.893+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.893+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio[814]: info: ------------------------------ 236ms Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.897+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio[814]: info: ------------------------------ 236ms Mar 04 12:09:21 volumio-10 volumio[814]: info: ------------------------------ 214ms Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.899+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 volumio[814]: info: ------------------------------ 214ms Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.906+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" state=STATUS_PLAYING positionMs=268 volume=41 Mar 04 12:09:21 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:21.906+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" id="http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fext-strm-vlvbln-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddc9b7eaab01452c39194dd39725a04670a32f35eefe0c0b2fe217fcf7c651d0a%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69b59ef4%2F0%2F5222349%2F70576d12.212972691.5.146408458%2Fflac-mp4&ext=.flac" title="COLD WAVES" Mar 04 12:09:21 volumio-10 sudo[24283]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:21 volumio-10 sudo[24286]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:21 volumio-10 volumio[814]: info: peppymeterbasic Daemon Started Mar 04 12:09:21 volumio-10 sudo[24296]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:21 volumio-10 sudo[24290]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:21 volumio-10 sudo[24293]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:21 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:21 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:21 volumio-10 sudo[24301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:21 volumio-10 sudo[24301]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:21 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:21 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:21 volumio-10 sudo[24304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:21 volumio-10 sudo[24304]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:22 volumio-10 sudo[24301]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:22 volumio-10 sudo[24306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:22 volumio-10 sudo[24306]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:22 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:22 volumio-10 sudo[24304]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:22 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:22 volumio-10 sudo[24309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:22 volumio-10 sudo[24309]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:22 volumio-10 sudo[24312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:22 volumio-10 sudo[24312]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:22 volumio-10 sudo[24306]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:22 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:22 volumio-10 sudo[24315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:22 volumio-10 sudo[24315]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:22 volumio-10 sudo[24309]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:22 volumio-10 volumio[814]: info: PeppyMeterBasic ---peppymeterbasic status play Mar 04 12:09:22 volumio-10 sudo[24315]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:22 volumio-10 sudo[24312]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:22 volumio-10 sudo[24319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:22 volumio-10 sudo[24319]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:22 volumio-10 sudo[24321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Mar 04 12:09:22 volumio-10 sudo[24321]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:22 volumio-10 sudo[24321]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:22 volumio-10 sudo[24319]: pam_unix(sudo:session): session closed for user root Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CoreStateMachine::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: CorePlayQueue::getQueue Mar 04 12:09:22 volumio-10 volumio[814]: info: peppymeterbasic Daemon Started Mar 04 12:09:22 volumio-10 volumio[814]: info: peppymeterbasic Daemon Started Mar 04 12:09:22 volumio-10 volumio[814]: info: peppymeterbasic Daemon Started Mar 04 12:09:22 volumio-10 volumio[814]: info: peppymeterbasic Daemon Started Mar 04 12:09:22 volumio-10 volumio[814]: info: peppymeterbasic Daemon Started Mar 04 12:09:22 volumio-10 volumio[814]: info: peppymeterbasic Daemon Started Mar 04 12:09:22 volumio-10 volumio[814]: info: peppymeterbasic Daemon Started Mar 04 12:09:22 volumio-10 volumio[814]: info: peppymeterbasic Daemon Started Mar 04 12:09:30 volumio-10 dhcpcd[951]: eth0: carrier lost Mar 04 12:09:30 volumio-10 kernel: bcmgenet fd580000.ethernet eth0: Link is Down Mar 04 12:09:30 volumio-10 dhcpcd[951]: eth0: deleting route to 192.168.0.0/24 Mar 04 12:09:30 volumio-10 dhcpcd[951]: eth0: deleting default route via 192.168.0.1 Mar 04 12:09:30 volumio-10 avahi-daemon[551]: Withdrawing address record for 192.168.0.141 on eth0. Mar 04 12:09:30 volumio-10 avahi-daemon[551]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.141. Mar 04 12:09:30 volumio-10 avahi-daemon[551]: Interface eth0.IPv4 no longer relevant for mDNS. Mar 04 12:09:30 volumio-10 volumio[814]: info: Discovery: A device disappeared from network Mar 04 12:09:31 volumio-10 volumio[814]: info: Received Get System Info Mar 04 12:09:31 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 12:09:31 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 12:09:31 volumio-10 volumio[814]: info: Discovery: Getting this device information Mar 04 12:09:31 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:31.003+09:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" available=true connected=false macAddress= ip4Address= ip6Address= Mar 04 12:09:31 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetState Mar 04 12:09:31 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 12:09:31 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 04 12:09:31 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 04 12:09:31 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:31.009+09:00 level=INFO msg="enabling BLE discovery" Mar 04 12:09:31 volumio-10 bluetoothd[694]: src/adapter.c:store_adapter_info() Unable set contents for /usr/var/lib/bluetooth/D8:3A:DD:AD:BC:7B/settings: (Failed to create file “/usr/var/lib/bluetooth/D8:3A:DD:AD:BC:7B/settings.NDFNL3”: No such file or directory) Mar 04 12:09:31 volumio-10 ifplugd(eth0)[759]: Link beat lost. Mar 04 12:09:32 volumio-10 ntpd[773]: Deleting interface #3 eth0, 192.168.0.141#123, interface stats: received=626, sent=659, dropped=0, active_time=5663 secs Mar 04 12:09:32 volumio-10 ntpd[773]: 90.188.9.144 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 92.241.18.100 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 89.109.251.23 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 89.109.251.24 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 217.170.87.229 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 93.191.12.44 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 193.106.93.116 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 93.95.100.85 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 91.197.207.24 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 91.188.214.68 local addr 192.168.0.141 -> Mar 04 12:09:32 volumio-10 ntpd[773]: 93.95.100.60 local addr 192.168.0.141 -> Mar 04 12:09:33 volumio-10 dhcpcd[951]: eth0: carrier acquired Mar 04 12:09:33 volumio-10 dhcpcd[951]: eth0: IAID dd:ad:bc:78 Mar 04 12:09:33 volumio-10 kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx Mar 04 12:09:33 volumio-10 dhcpcd[951]: eth0: soliciting an IPv6 router Mar 04 12:09:34 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:34.043+09:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.174:55868 @ 0x1c00030" available=true connected=false macAddress= ip4Address= ip6Address= Mar 04 12:09:34 volumio-10 volumio[814]: info: Received Get System Info Mar 04 12:09:34 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 12:09:34 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 12:09:34 volumio-10 volumio[814]: info: Discovery: Getting this device information Mar 04 12:09:34 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetState Mar 04 12:09:34 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 12:09:34 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 04 12:09:34 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 04 12:09:34 volumio-10 ifplugd(eth0)[759]: Link beat detected. Mar 04 12:09:34 volumio-10 dhcpcd[951]: eth0: soliciting a DHCP lease Mar 04 12:09:34 volumio-10 dhcpcd[951]: eth0: offered 192.168.0.141 from 192.168.0.1 Mar 04 12:09:34 volumio-10 dhcpcd[951]: eth0: probing address 192.168.0.141/24 Mar 04 12:09:39 volumio-10 dhcpcd[951]: eth0: leased 192.168.0.141 for 86400 seconds Mar 04 12:09:39 volumio-10 dhcpcd[951]: eth0: adding route to 192.168.0.0/24 Mar 04 12:09:39 volumio-10 dhcpcd[951]: eth0: adding default route via 192.168.0.1 Mar 04 12:09:39 volumio-10 avahi-daemon[551]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.141. Mar 04 12:09:39 volumio-10 avahi-daemon[551]: New relevant interface eth0.IPv4 for mDNS. Mar 04 12:09:39 volumio-10 avahi-daemon[551]: Registering new address record for 192.168.0.141 on eth0.IPv4. Mar 04 12:09:39 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:39.617+09:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.0.174:55868 Mar 04 12:09:39 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:39.617+09:00 level=ERROR msg="failed to send response" component=server dst="192.168.0.174:55868 @ 0x1c00030" id=750973340 status=STATUS_OK error="no WebSocket connection found for address: 192.168.0.174:55868" Mar 04 12:09:39 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:39.617+09:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.0.174:55868 Mar 04 12:09:39 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:39.617+09:00 level=ERROR msg="failed to send response" component=server dst="192.168.0.174:55868 @ 0x1c00030" id=1321577712 status=STATUS_OK error="no WebSocket connection found for address: 192.168.0.174:55868" Mar 04 12:09:39 volumio-10 volumio[814]: info: Received Get System Info Mar 04 12:09:39 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 12:09:39 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 12:09:39 volumio-10 volumio[814]: info: Discovery: Getting this device information Mar 04 12:09:39 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetState Mar 04 12:09:39 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 12:09:39 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 04 12:09:39 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 04 12:09:39 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:39.890+09:00 level=INFO msg="disabling BLE discovery" Mar 04 12:09:39 volumio-10 volumio5-onboarding[1035]: time=2026-03-04T12:09:39.893+09:00 level=INFO msg="connection closed, stopping read loop" component=conn/multi net=ble addr=D8:3A:DD:AD:BC:7B%00 Mar 04 12:09:40 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 04 12:09:40 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 04 12:09:40 volumio-10 volumio[814]: info: Discovery: Getting this device information Mar 04 12:09:40 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetState Mar 04 12:09:40 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 04 12:09:40 volumio-10 volumio[814]: verbose: New Socket.io Connection to 192.168.0.141:3000 from 192.168.0.174 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Mar 04 12:09:40 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 04 12:09:40 volumio-10 volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 04 12:09:40 volumio-10 volumio[814]: info: Discovery: adding 3301d4e9-9876-416a-9e0d-baff6871c0fc Mar 04 12:09:40 volumio-10 volumio[814]: info: Discovery: Found device Volumio 10 Mar 04 12:09:40 volumio-10 volumio[814]: info: CoreCommandRouter::volumioGetState Mar 04 12:09:40 volumio-10 volumio[814]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 12:09:40 volumio-10 volumio[814]: Error: read ECONNRESET Mar 04 12:09:40 volumio-10 volumio[814]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Mar 04 12:09:40 volumio-10 volumio[814]: errno: -104, Mar 04 12:09:40 volumio-10 volumio[814]: code: 'ECONNRESET', Mar 04 12:09:40 volumio-10 volumio[814]: syscall: 'read' Mar 04 12:09:40 volumio-10 volumio[814]: } Mar 04 12:09:40 volumio-10 volumio[814]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 12:09:40 volumio-10 sudo[24458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-04 12:08 Mar 04 12:09:40 volumio-10 sudo[24458]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" 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 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"