-- Logs begin at Thu 2019-02-14 19:11:58 +09, end at Wed 2026-02-25 11:00:13 +09. --
Feb 25 10:59:16 volumio-10 volumiologrotate[619]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Feb 25 10:59:16 volumio-10 volumiologrotate[619]: ls: cannot access '10': No such file or directory
Feb 25 10:59:32 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 10:59:32 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 10:59:32 volumio-10 volumio[1126]: info: Discovery: Getting this device information
Feb 25 10:59:32 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 10:59:32 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 10:59:32 volumio-10 volumio[1126]: verbose: New Socket.io Connection to 192.168.0.142:3000 from 192.168.0.174 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Feb 25 10:59:32 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 10:59:32 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 10:59:59 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 6
Feb 25 10:59:59 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 10:59:59 volumio-10 volumio[1126]: info: Prefetching next song
Feb 25 10:59:59 volumio-10 volumio[1126]: 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac"
Feb 25 10:59:59 volumio-10 volumio[1126]: info:
Feb 25 10:59:59 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 10:59:59 volumio-10 volumio[1126]: 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" took 2 milliseconds
Feb 25 10:59:59 volumio-10 volumio[1126]: verbose: MPD COMMAND [object Object]
Feb 25 10:59:59 volumio-10 volumio[1126]: verbose: MPD COMMAND [object Object]
Feb 25 10:59:59 volumio-10 volumio[1126]: info:
Feb 25 10:59:59 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 10:59:59 volumio-10 volumio[1126]: info:
Feb 25 10:59:59 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 10:59:59 volumio-10 volumio[1126]: info:
Feb 25 10:59:59 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 10:59:59 volumio-10 volumio[1126]: info:
Feb 25 10:59:59 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: ------------------------------ 4ms
Feb 25 10:59:59 volumio-10 volumio[1126]: info: ------------------------------ 2ms
Feb 25 10:59:59 volumio-10 volumio[1126]: info: ------------------------------ 2ms
Feb 25 10:59:59 volumio-10 volumio[1126]: info: ------------------------------ 2ms
Feb 25 10:59:59 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand consume 1
Feb 25 10:59:59 volumio-10 volumio[1126]: info:
Feb 25 10:59:59 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 10:59:59 volumio-10 volumio[1126]: info:
Feb 25 10:59:59 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 10:59:59 volumio-10 volumio[1126]: info:
Feb 25 10:59:59 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 10:59:59 volumio-10 volumio[1126]: info: ------------------------------ 3ms
Feb 25 10:59:59 volumio-10 volumio[1126]: info: sendMpdCommand consume 1 took 2 milliseconds
Feb 25 10:59:59 volumio-10 volumio[1126]: info: ------------------------------ 2ms
Feb 25 10:59:59 volumio-10 volumio[1126]: info: ------------------------------ 2ms
Feb 25 11:00:03 volumio-10 dhcpcd[900]: eth0: carrier lost
Feb 25 11:00:03 volumio-10 dhcpcd[1031]: eth0: carrier lost
Feb 25 11:00:03 volumio-10 kernel: bcmgenet fd580000.ethernet eth0: Link is Down
Feb 25 11:00:03 volumio-10 avahi-daemon[618]: Withdrawing address record for 192.168.0.141 on eth0.
Feb 25 11:00:03 volumio-10 avahi-daemon[618]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.141.
Feb 25 11:00:03 volumio-10 volumio[1126]: info: Discovery: A device disappeared from network
Feb 25 11:00:03 volumio-10 avahi-daemon[618]: Interface eth0.IPv4 no longer relevant for mDNS.
Feb 25 11:00:03 volumio-10 dhcpcd[900]: eth0: deleting route to 192.168.0.0/24
Feb 25 11:00:03 volumio-10 dhcpcd[1031]: eth0: deleting route to 192.168.0.0/24
Feb 25 11:00:03 volumio-10 dhcpcd[1031]: eth0: deleting default route via 192.168.0.1
Feb 25 11:00:03 volumio-10 ifplugd(eth0)[753]: Link beat lost.
Feb 25 11:00:03 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:03.652+09:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" available=true connected=false macAddress= ip4Address= ip6Address=
Feb 25 11:00:03 volumio-10 volumio[1126]: info: Received Get System Info
Feb 25 11:00:03 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 11:00:03 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 11:00:03 volumio-10 volumio[1126]: info: Discovery: Getting this device information
Feb 25 11:00:03 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 11:00:03 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 11:00:03 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 11:00:03 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 11:00:03 volumio-10 volumio[1126]: info: CoreStateMachine::startPlaybackTimer
Feb 25 11:00:03 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:04 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:04 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:04 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 25 11:00:04 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:04 volumio-10 volumio[1126]: info: CoreStateMachine::setConsumeUpdateService mpd
Feb 25 11:00:04 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:04.075+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=250 volume=25
Feb 25 11:00:04 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:04.076+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" id=yandex_music/track/147612868:40396567@503646255:153863392 title="Real Brother"
Feb 25 11:00:04 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:04 volumio-10 sudo[9923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:04 volumio-10 sudo[9923]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:04 volumio-10 sudo[9923]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:04 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:04 volumio-10 volumio[1126]: info:
Feb 25 11:00:04 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 11:00:04 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 11:00:04 volumio-10 volumio[1126]: info:
Feb 25 11:00:04 volumio-10 volumio[1126]: ---------------------------- MPD announces state update: player
Feb 25 11:00:04 volumio-10 ntpd[755]: Deleting interface #5 eth0, 192.168.0.141#123, interface stats: received=230, sent=241, dropped=0, active_time=851 secs
Feb 25 11:00:04 volumio-10 volumio[1126]: info: ControllerMpd::getState
Feb 25 11:00:04 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 11:00:04 volumio-10 volumio[1126]: info:
Feb 25 11:00:04 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 11:00:04 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 11:00:04 volumio-10 volumio[1126]: info:
Feb 25 11:00:04 volumio-10 volumio[1126]: ---------------------------- MPD announces state update: player
Feb 25 11:00:04 volumio-10 volumio[1126]: info: ControllerMpd::getState
Feb 25 11:00:04 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 11:00:04 volumio-10 volumio[1126]: info:
Feb 25 11:00:04 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 11:00:04 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 11:00:04 volumio-10 volumio[1126]: info:
Feb 25 11:00:04 volumio-10 volumio[1126]: ---------------------------- MPD announces state update: player
Feb 25 11:00:04 volumio-10 ntpd[755]: 85.142.100.8 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 volumio[1126]: info: ControllerMpd::getState
Feb 25 11:00:04 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 11:00:04 volumio-10 volumio[1126]: info:
Feb 25 11:00:04 volumio-10 volumio[1126]: ---------------------------- MPD announces system playlist update
Feb 25 11:00:04 volumio-10 volumio[1126]: info: Ignoring MPD Status Update
Feb 25 11:00:04 volumio-10 volumio[1126]: info:
Feb 25 11:00:04 volumio-10 volumio[1126]: ---------------------------- MPD announces state update: player
Feb 25 11:00:04 volumio-10 volumio[1126]: info: ControllerMpd::getState
Feb 25 11:00:04 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 11:00:04 volumio-10 ntpd[755]: 109.206.145.96 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 195.54.177.84 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 92.255.126.17 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 95.79.45.228 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 92.241.18.100 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 91.188.214.68 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 92.255.126.1 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 93.95.100.60 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 217.69.139.133 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 83.167.27.4 local addr 192.168.0.141 ->
Feb 25 11:00:04 volumio-10 ntpd[755]: 91.206.16.3 local addr 192.168.0.141 ->
Feb 25 11:00:05 volumio-10 volumio[1126]: info:
Feb 25 11:00:05 volumio-10 volumio[1126]: ---------------------------- MPD announces state update: player
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 998ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand status took 998 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 997ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand status took 997 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 996ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand status took 996 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::getState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 1003ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand status took 1002 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand status took 8 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand playlistinfo took 7 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::servicePushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1603 Kbps","isStreaming":false,"title":"Real Brother","artist":"Domus Made","album":"Real Brother","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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: CURRENT POSITION 7
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState stateService play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: Received an update from plugin. extracting info from payload
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::servicePushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1603 Kbps","isStreaming":false,"title":"Real Brother","artist":"Domus Made","album":"Real Brother","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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: CURRENT POSITION 7
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState stateService play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: Received an update from plugin. extracting info from payload
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::servicePushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":217,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1603 Kbps","isStreaming":false,"title":"Real Brother","artist":"Domus Made","album":"Real Brother","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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: CURRENT POSITION 7
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState stateService play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: Received an update from plugin. extracting info from payload
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.474+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1502 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.474+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.476+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1502 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.476+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.477+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1502 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.477+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.478+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1502 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.478+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.480+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1502 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.480+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.482+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1502 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.482+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 1067ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 1067ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 1067ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info:
Feb 25 11:00:05 volumio-10 volumio[1126]: ---------------------------- MPD announces state update: player
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::getState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 11:00:05 volumio-10 volumio[1126]: info:
Feb 25 11:00:05 volumio-10 volumio[1126]: ---------------------------- MPD announces state update: player
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::getState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 11:00:05 volumio-10 volumio[1126]: info:
Feb 25 11:00:05 volumio-10 volumio[1126]: ---------------------------- MPD announces state update: player
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::getState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand playlistinfo took 68 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand status took 5 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand status took 4 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand status took 2 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseState
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::servicePushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114,"duration":217,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1603 Kbps","isStreaming":false,"title":"Real Brother","artist":"Domus Made","album":"Real Brother","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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: CURRENT POSITION 7
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState stateService play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: Received an update from plugin. extracting info from payload
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::servicePushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":217,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1603 Kbps","isStreaming":false,"title":"Real Brother","artist":"Domus Made","album":"Real Brother","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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: CURRENT POSITION 7
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState stateService play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: Received an update from plugin. extracting info from payload
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.549+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1769 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.549+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.551+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1769 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.551+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.552+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1769 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.552+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.553+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=1769 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.553+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 1124ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 131ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9930]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9930]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9933]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 sudo[9935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9935]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9939]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9933]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 sudo[9935]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 sudo[9941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9941]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9939]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 sudo[9945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9941]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 sudo[9945]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9947]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 sudo[9945]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9950]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 sudo[9947]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 sudo[9953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9953]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 sudo[9950]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 sudo[9956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 sudo[9956]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 sudo[9953]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 sudo[9956]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand playlistinfo took 326 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand playlistinfo took 325 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: info: sendMpdCommand playlistinfo took 325 milliseconds
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: ControllerMpd::parseTrackInfo
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::servicePushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":217,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1603 Kbps","isStreaming":false,"title":"Real Brother","artist":"Domus Made","album":"Real Brother","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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: CURRENT POSITION 7
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState stateService play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: Received an update from plugin. extracting info from payload
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::servicePushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":217,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1603 Kbps","isStreaming":false,"title":"Real Brother","artist":"Domus Made","album":"Real Brother","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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: CURRENT POSITION 7
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState stateService play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: Received an update from plugin. extracting info from payload
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ControllerMpd::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::servicePushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CorePlayQueue::getTrack 7
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":217,"samplerate":"44.1 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1603 Kbps","isStreaming":false,"title":"Real Brother","artist":"Domus Made","album":"Real Brother","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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac","trackType":"flac"}
Feb 25 11:00:05 volumio-10 volumio[1126]: verbose: CURRENT POSITION 7
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState stateService play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::syncState currentStatus play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: Received an update from plugin. extracting info from payload
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreStateMachine::pushState
Feb 25 11:00:05 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioPushState
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.870+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=2097 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.870+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.871+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=2097 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.872+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.873+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=2097 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.874+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.875+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=2097 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.875+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.877+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=2097 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.877+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.878+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" state=STATUS_PLAYING positionMs=2097 volume=25
Feb 25 11:00:05 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:05.878+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" 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%3Dc54e034ffa346f3e024460af63d9e626eb1c25deb487e80688e9a292cd6329b9%2Clid%3D1602%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D69ac3102%2F0%2F1615056%2Fefd82213.214832224.5.147612868%2Fflac-mp4&ext=.flac" title="Real Brother"
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 390ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 389ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: ------------------------------ 389ms
Feb 25 11:00:05 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:05 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:05 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:05 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:05 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:05 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:05 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9960]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9963]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9960]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 sudo[9965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9965]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:05 volumio-10 sudo[9963]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:05 volumio-10 sudo[9969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:05 volumio-10 sudo[9969]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:05 volumio-10 sudo[9965]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:06 volumio-10 volumio[1126]: info: PeppyMeterBasic ---peppymeterbasic status play
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:06 volumio-10 sudo[9972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:06 volumio-10 sudo[9972]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:06 volumio-10 sudo[9969]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:06 volumio-10 sudo[9974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service
Feb 25 11:00:06 volumio-10 sudo[9974]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:06 volumio-10 sudo[9972]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreStateMachine::getQueue
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CorePlayQueue::getQueue
Feb 25 11:00:06 volumio-10 sudo[9974]: pam_unix(sudo:session): session closed for user root
Feb 25 11:00:06 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:06 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:06 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:06 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:06 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:06 volumio-10 volumio[1126]: info: peppymeterbasic Daemon Started
Feb 25 11:00:06 volumio-10 dhcpcd[900]: eth0: carrier acquired
Feb 25 11:00:06 volumio-10 dhcpcd[1031]: eth0: carrier acquired
Feb 25 11:00:06 volumio-10 dhcpcd[900]: eth0: IAID dd:ad:bc:78
Feb 25 11:00:06 volumio-10 dhcpcd[1031]: eth0: IAID dd:ad:bc:78
Feb 25 11:00:06 volumio-10 kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 100Mbps/Full - flow control rx/tx
Feb 25 11:00:06 volumio-10 dhcpcd[900]: eth0: rebinding lease of 192.168.0.141
Feb 25 11:00:06 volumio-10 dhcpcd[900]: eth0: probing address 192.168.0.141/24
Feb 25 11:00:06 volumio-10 ifplugd(eth0)[753]: Link beat detected.
Feb 25 11:00:06 volumio-10 dhcpcd[900]: eth0: soliciting an IPv6 router
Feb 25 11:00:06 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:06.682+09:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" available=true connected=false macAddress= ip4Address= ip6Address=
Feb 25 11:00:06 volumio-10 volumio[1126]: info: Received Get System Info
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 11:00:06 volumio-10 volumio[1126]: info: Discovery: Getting this device information
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 11:00:06 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 11:00:06 volumio-10 dhcpcd[1031]: eth0: rebinding lease of 192.168.0.141
Feb 25 11:00:06 volumio-10 dhcpcd[1031]: eth0: probing address 192.168.0.141/24
Feb 25 11:00:06 volumio-10 dhcpcd[1031]: eth0: soliciting an IPv6 router
Feb 25 11:00:08 volumio-10 ntpd[755]: Soliciting pool server 83.237.235.30
Feb 25 11:00:09 volumio-10 ntpd[755]: Soliciting pool server 94.100.180.133
Feb 25 11:00:10 volumio-10 ntpd[755]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Feb 25 11:00:10 volumio-10 volumio[1126]: info: Volumio Network Manager: Network status updated: 2
Feb 25 11:00:11 volumio-10 dhcpcd[900]: eth0: leased 192.168.0.141 for 86400 seconds
Feb 25 11:00:11 volumio-10 dhcpcd[900]: eth0: adding route to 192.168.0.0/24
Feb 25 11:00:11 volumio-10 avahi-daemon[618]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.141.
Feb 25 11:00:11 volumio-10 avahi-daemon[618]: New relevant interface eth0.IPv4 for mDNS.
Feb 25 11:00:11 volumio-10 dhcpcd[900]: eth0: adding default route via 192.168.0.1
Feb 25 11:00:11 volumio-10 avahi-daemon[618]: Registering new address record for 192.168.0.141 on eth0.IPv4.
Feb 25 11:00:11 volumio-10 dhcpcd[1031]: eth0: leased 192.168.0.141 for 86400 seconds
Feb 25 11:00:11 volumio-10 dhcpcd[1031]: eth0: adding route to 192.168.0.0/24
Feb 25 11:00:11 volumio-10 dhcpcd[1031]: eth0: adding default route via 192.168.0.1
Feb 25 11:00:12 volumio-10 volumio5-onboarding[1297]: time=2026-02-25T11:00:12.351+09:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.174:48590,192.168.0.174:59912 @ 0x1da4cc0" available=true connected=true macAddress=d8:3a:dd:ad:bc:78 ip4Address=192.168.0.141/24 ip6Address=
Feb 25 11:00:12 volumio-10 volumio[1126]: info: Received Get System Info
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 11:00:12 volumio-10 volumio[1126]: info: Discovery: Getting this device information
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 11:00:12 volumio-10 volumio[1126]: info: Discovery: Getting this device information
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 11:00:12 volumio-10 volumio[1126]: info: Discovery: adding 3301d4e9-9876-416a-9e0d-baff6871c0fc
Feb 25 11:00:12 volumio-10 volumio[1126]: info: Discovery: Found device Volumio 10
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 11:00:12 volumio-10 volumio[1126]: 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: 8
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 11:00:12 volumio-10 volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 11:00:13 volumio-10 volumio[1126]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 11:00:13 volumio-10 volumio[1126]: Error: read ECONNRESET
Feb 25 11:00:13 volumio-10 volumio[1126]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) {
Feb 25 11:00:13 volumio-10 volumio[1126]: errno: -104,
Feb 25 11:00:13 volumio-10 volumio[1126]: code: 'ECONNRESET',
Feb 25 11:00:13 volumio-10 volumio[1126]: syscall: 'read'
Feb 25 11:00:13 volumio-10 volumio[1126]: }
Feb 25 11:00:13 volumio-10 volumio[1126]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 11:00:13 volumio-10 ntpd[755]: Listen normally on 7 eth0 192.168.0.141:123
Feb 25 11:00:13 volumio-10 ntpd[755]: new interface(s) found: waking up resolver
Feb 25 11:00:13 volumio-10 sudo[10063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-25 10:59
Feb 25 11:00:13 volumio-10 sudo[10063]: 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"