Dec 27 07:27:00 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:00+01:00" level=debug msg="update volume requested to 16776/65535" Dec 27 07:27:01 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:01+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 27 07:27:01 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:01+01:00" level=trace msg="emitting websocket event: volume" Dec 27 07:27:01 volumio-4 volumio[1499]: SPOTIFY: received: {"type":"volume","data":{"value":26,"max":100}} Dec 27 07:27:01 volumio-4 volumio[1499]: SPOTIFY: RECEIVED SPOTIFY VOLUME 26 Dec 27 07:27:01 volumio-4 volumio[1499]: info: Setting Volumio Volume from Spotify: 26 Dec 27 07:27:01 volumio-4 volumio[1499]: info: VolumeController::SetAlsaVolume26 Dec 27 07:27:01 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:01 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:01 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:01 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:01 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:01 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 26 Dec 27 07:27:01 volumio-4 sudo[5525]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:01 volumio-4 sudo[5525]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:01 volumio-4 sudo[5525]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:01 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:01 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:01+01:00" level=debug msg="update volume requested to 7634/65535" Dec 27 07:27:01 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:01+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 27 07:27:01 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:01+01:00" level=trace msg="emitting websocket event: volume" Dec 27 07:27:01 volumio-4 volumio[1499]: SPOTIFY: received: {"type":"volume","data":{"value":12,"max":100}} Dec 27 07:27:01 volumio-4 volumio[1499]: SPOTIFY: RECEIVED SPOTIFY VOLUME 12 Dec 27 07:27:01 volumio-4 volumio[1499]: info: Setting Volumio Volume from Spotify: 12 Dec 27 07:27:01 volumio-4 volumio[1499]: info: VolumeController::SetAlsaVolume12 Dec 27 07:27:01 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:01 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:01 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:01 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:01 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:01 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 12 Dec 27 07:27:01 volumio-4 sudo[5529]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:01 volumio-4 sudo[5529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:01 volumio-4 sudo[5529]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:01 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:01 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:01+01:00" level=debug msg="update volume requested to 4587/65535" Dec 27 07:27:01 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:01+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 27 07:27:01 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:01+01:00" level=trace msg="emitting websocket event: volume" Dec 27 07:27:01 volumio-4 volumio[1499]: SPOTIFY: received: {"type":"volume","data":{"value":7,"max":100}} Dec 27 07:27:01 volumio-4 volumio[1499]: SPOTIFY: RECEIVED SPOTIFY VOLUME 7 Dec 27 07:27:01 volumio-4 volumio[1499]: info: Setting Volumio Volume from Spotify: 7 Dec 27 07:27:01 volumio-4 volumio[1499]: info: VolumeController::SetAlsaVolume7 Dec 27 07:27:01 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:01 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:01 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:01 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:01 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:01 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 7 Dec 27 07:27:01 volumio-4 sudo[5533]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:01 volumio-4 sudo[5533]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:01 volumio-4 sudo[5533]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:01 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:01+01:00" level=debug msg="update volume requested to 1966/65535" Dec 27 07:27:01 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:02 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:02+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 27 07:27:02 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:02+01:00" level=trace msg="emitting websocket event: volume" Dec 27 07:27:02 volumio-4 volumio[1499]: SPOTIFY: received: {"type":"volume","data":{"value":3,"max":100}} Dec 27 07:27:02 volumio-4 volumio[1499]: SPOTIFY: RECEIVED SPOTIFY VOLUME 3 Dec 27 07:27:02 volumio-4 volumio[1499]: info: Setting Volumio Volume from Spotify: 3 Dec 27 07:27:02 volumio-4 volumio[1499]: info: VolumeController::SetAlsaVolume3 Dec 27 07:27:02 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:02 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:02 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:02 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:02 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:02 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 3 Dec 27 07:27:02 volumio-4 sudo[5538]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:02 volumio-4 sudo[5538]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:02 volumio-4 sudo[5538]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:02 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:03 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:03+01:00" level=debug msg="update volume requested to 4587/65535" Dec 27 07:27:03 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:03+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 27 07:27:03 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:03+01:00" level=trace msg="emitting websocket event: volume" Dec 27 07:27:03 volumio-4 volumio[1499]: SPOTIFY: received: {"type":"volume","data":{"value":7,"max":100}} Dec 27 07:27:03 volumio-4 volumio[1499]: SPOTIFY: RECEIVED SPOTIFY VOLUME 7 Dec 27 07:27:03 volumio-4 volumio[1499]: info: Setting Volumio Volume from Spotify: 7 Dec 27 07:27:03 volumio-4 volumio[1499]: info: VolumeController::SetAlsaVolume7 Dec 27 07:27:03 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:03 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:03 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:03 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:03 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:03 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 7 Dec 27 07:27:03 volumio-4 sudo[5549]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:03 volumio-4 sudo[5549]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:03 volumio-4 sudo[5549]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:03 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:03 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:03+01:00" level=debug msg="update volume requested to 7209/65535" Dec 27 07:27:03 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:03+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 27 07:27:03 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:03+01:00" level=trace msg="emitting websocket event: volume" Dec 27 07:27:03 volumio-4 volumio[1499]: SPOTIFY: received: {"type":"volume","data":{"value":11,"max":100}} Dec 27 07:27:03 volumio-4 volumio[1499]: SPOTIFY: RECEIVED SPOTIFY VOLUME 11 Dec 27 07:27:03 volumio-4 volumio[1499]: info: Setting Volumio Volume from Spotify: 11 Dec 27 07:27:04 volumio-4 volumio[1499]: info: VolumeController::SetAlsaVolume11 Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:04 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:04 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:04 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Dec 27 07:27:04 volumio-4 sudo[5553]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:04 volumio-4 sudo[5553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:04 volumio-4 sudo[5553]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:04 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:04 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:04+01:00" level=debug msg="update volume requested to 9830/65535" Dec 27 07:27:04 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:04+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 27 07:27:04 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:04+01:00" level=trace msg="emitting websocket event: volume" Dec 27 07:27:04 volumio-4 volumio[1499]: SPOTIFY: received: {"type":"volume","data":{"value":15,"max":100}} Dec 27 07:27:04 volumio-4 volumio[1499]: SPOTIFY: RECEIVED SPOTIFY VOLUME 15 Dec 27 07:27:04 volumio-4 volumio[1499]: info: Setting Volumio Volume from Spotify: 15 Dec 27 07:27:04 volumio-4 volumio[1499]: info: VolumeController::SetAlsaVolume15 Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:04 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:04 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:04 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 15 Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioGetState Dec 27 07:27:04 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:04 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:04+01:00" level=debug msg="update volume requested to 12452/65535" Dec 27 07:27:04 volumio-4 sudo[5557]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:04 volumio-4 sudo[5557]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:04 volumio-4 sudo[5557]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:04 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:04 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:04+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 27 07:27:04 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:04+01:00" level=trace msg="emitting websocket event: volume" Dec 27 07:27:04 volumio-4 volumio[1499]: SPOTIFY: received: {"type":"volume","data":{"value":19,"max":100}} Dec 27 07:27:04 volumio-4 volumio[1499]: SPOTIFY: RECEIVED SPOTIFY VOLUME 19 Dec 27 07:27:04 volumio-4 volumio[1499]: info: Setting Volumio Volume from Spotify: 19 Dec 27 07:27:04 volumio-4 volumio[1499]: info: VolumeController::SetAlsaVolume19 Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:04 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:04 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:04 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:04 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:04 volumio-4 sudo[5561]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:04 volumio-4 sudo[5561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:04 volumio-4 sudo[5561]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:04 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:14 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioGetState Dec 27 07:27:14 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:14 volumio-4 volumio[1499]: info: Listing playlists Dec 27 07:27:14 volumio-4 volumio[1499]: info: Listing playlists Dec 27 07:27:19 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:19+01:00" level=trace msg="sent dealer ping" Dec 27 07:27:19 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:19+01:00" level=trace msg="received dealer pong" Dec 27 07:27:24 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioGetState Dec 27 07:27:24 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:32 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPlay Dec 27 07:27:32 volumio-4 volumio[1499]: info: CoreStateMachine::play index undefined Dec 27 07:27:32 volumio-4 volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 07:27:32 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:32 volumio-4 volumio[1499]: info: CoreStateMachine::startPlaybackTimer Dec 27 07:27:32 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:32 volumio-4 volumio[1499]: info: [1766816852641] ControllerWebradio::clearAddPlayTrack Dec 27 07:27:32 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand stop Dec 27 07:27:32 volumio-4 volumio[1499]: info: sendMpdCommand stop took 1 milliseconds Dec 27 07:27:32 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand clear Dec 27 07:27:32 volumio-4 volumio[1499]: info: Dec 27 07:27:32 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:32 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:32 volumio-4 volumio[1499]: info: sendMpdCommand clear took 0 milliseconds Dec 27 07:27:32 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand load "https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream" Dec 27 07:27:32 volumio-4 volumio[1499]: info: Dec 27 07:27:32 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:32 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:32 volumio-4 volumio[1499]: error: updateQueue error: null Dec 27 07:27:32 volumio-4 volumio[1499]: info: ------------------------------ 1ms Dec 27 07:27:32 volumio-4 volumio[1499]: info: Dec 27 07:27:32 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:32 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:32 volumio-4 volumio[1499]: info: Dec 27 07:27:32 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:32 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand add "https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream" Dec 27 07:27:33 volumio-4 volumio[1499]: error: updateQueue error: null Dec 27 07:27:33 volumio-4 volumio[1499]: error: updateQueue error: null Dec 27 07:27:33 volumio-4 volumio[1499]: error: updateQueue error: null Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 432ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 432ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 432ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand add "https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream" took 0 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand play Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 2ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand play took 2 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 1ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 1ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 1ms Dec 27 07:27:33 volumio-4 ntpd[1300]: PROTO: 136.243.7.20 unlink local addr 192.168.88.191 -> Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand status took 35 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand status took 35 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand status took 36 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand status took 35 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand status took 6 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 6ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand status took 4 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 4ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand status took 3 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 3ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand status took 3 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus stop Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":481,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:33 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":481,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:33 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":481,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:33 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 50ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 75ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 76ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 75ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: Dec 27 07:27:33 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:33 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 36 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 36 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 35 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 38 milliseconds Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:33 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:33 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:33 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:33 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:33 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 112ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 109ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 109ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 109ms Dec 27 07:27:33 volumio-4 kernel: drm-rp1-dsi 1f00130000.dsi: [drm] rp1dsi: Command time (outvact): 33 Dec 27 07:27:33 volumio-4 kernel: drm-rp1-dsi 1f00130000.dsi: [drm] rp1dsi: Nominal Byte clock 90000000 DPI clock 30000000 (parent rate 90000000) Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 sudo[5650]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5650]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 sudo[5652]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5652]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 sudo[5656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 sudo[5659]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5659]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 sudo[5665]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5665]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 sudo[5661]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5661]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 sudo[5666]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 sudo[5671]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 sudo[5671]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 sudo[5674]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 27 07:27:33 volumio-4 sudo[5674]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 sudo[5676]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5676]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:33 volumio-4 sudo[5650]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5682]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5684]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 sudo[5682]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 sudo[5687]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5687]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 sudo[5652]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5689]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:33 volumio-4 sudo[5689]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:33 volumio-4 volumio[1499]: info: ------------------------------ 217ms Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 sudo[5671]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5666]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5687]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5665]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5689]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 sudo[5676]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5656]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5661]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5659]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5684]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 sudo[5682]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 sudo[5674]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:33 volumio-4 volumio[1499]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 27 07:27:34 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioGetState Dec 27 07:27:34 volumio-4 volumio[1499]: info: Listing playlists Dec 27 07:27:34 volumio-4 volumio[1499]: info: Listing playlists Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioStop Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::stop Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::stPlaybackTimer Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::updateTrackBlock Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrackBlock Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::serviceStop Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::serviceStop Dec 27 07:27:36 volumio-4 volumio[1499]: info: [1766816856157] ControllerWebradio::stop Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand stop Dec 27 07:27:36 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:36 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:36 volumio-4 sudo[5719]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:36 volumio-4 sudo[5719]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:36 volumio-4 volumio[1499]: info: Dec 27 07:27:36 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:36 volumio-4 volumio[1499]: info: sendMpdCommand stop took 31 milliseconds Dec 27 07:27:36 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:36 volumio-4 volumio[1499]: info: Dec 27 07:27:36 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:36 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:36 volumio-4 volumio[1499]: info: Dec 27 07:27:36 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:36 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:36 volumio-4 volumio[1499]: info: Dec 27 07:27:36 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:36 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:36 volumio-4 volumio[1499]: info: sendMpdCommand status took 3 milliseconds Dec 27 07:27:36 volumio-4 volumio[1499]: info: sendMpdCommand status took 2 milliseconds Dec 27 07:27:36 volumio-4 volumio[1499]: info: sendMpdCommand status took 2 milliseconds Dec 27 07:27:36 volumio-4 volumio[1499]: info: sendMpdCommand status took 1 milliseconds Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:36 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 27 07:27:36 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 27 07:27:36 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 27 07:27:36 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:36 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:36 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 27 07:27:36 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:36 volumio-4 systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 27 07:27:36 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 27 07:27:36 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:36 volumio-4 systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 27 07:27:36 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:36 volumio-4 volumio[1499]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 27 07:27:36 volumio-4 systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 27 07:27:36 volumio-4 sudo[5719]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:36 volumio-4 volumio[1499]: info: ------------------------------ 50ms Dec 27 07:27:36 volumio-4 volumio[1499]: info: ------------------------------ 49ms Dec 27 07:27:36 volumio-4 volumio[1499]: info: ------------------------------ 48ms Dec 27 07:27:36 volumio-4 volumio[1499]: info: ------------------------------ 48ms Dec 27 07:27:36 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:36 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:36 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:36 volumio-4 sudo[5724]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:36 volumio-4 sudo[5724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:36 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:36 volumio-4 sudo[5726]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:36 volumio-4 sudo[5726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:36 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:36 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:36 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:36 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:36 volumio-4 sudo[5728]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:36 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:36 volumio-4 volumio[1499]: info: touch_display: Setting screensaver timeout to 100 seconds. Dec 27 07:27:36 volumio-4 sudo[5728]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:36 volumio-4 sudo[5732]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:36 volumio-4 sudo[5732]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:36 volumio-4 sudo[5724]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:36 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:36 volumio-4 sudo[5726]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:36 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:36 volumio-4 sudo[5732]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:36 volumio-4 sudo[5728]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:36 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:36 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:38 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPlay Dec 27 07:27:38 volumio-4 volumio[1499]: info: CoreStateMachine::play index undefined Dec 27 07:27:38 volumio-4 volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 07:27:38 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:38 volumio-4 volumio[1499]: info: CoreStateMachine::startPlaybackTimer Dec 27 07:27:38 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:38 volumio-4 volumio[1499]: info: [1766816858945] ControllerWebradio::clearAddPlayTrack Dec 27 07:27:38 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand stop Dec 27 07:27:38 volumio-4 volumio[1499]: info: sendMpdCommand stop took 0 milliseconds Dec 27 07:27:38 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand clear Dec 27 07:27:38 volumio-4 volumio[1499]: info: sendMpdCommand clear took 0 milliseconds Dec 27 07:27:38 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand load "https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream" Dec 27 07:27:38 volumio-4 volumio[1499]: info: Dec 27 07:27:38 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:38 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:38 volumio-4 volumio[1499]: info: Dec 27 07:27:38 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:38 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:38 volumio-4 volumio[1499]: info: Dec 27 07:27:38 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:38 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:38 volumio-4 volumio[1499]: info: Dec 27 07:27:38 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:38 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand add "https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream" Dec 27 07:27:39 volumio-4 volumio[1499]: error: updateQueue error: null Dec 27 07:27:39 volumio-4 volumio[1499]: error: updateQueue error: null Dec 27 07:27:39 volumio-4 volumio[1499]: error: updateQueue error: null Dec 27 07:27:39 volumio-4 volumio[1499]: error: updateQueue error: null Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 386ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 386ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 386ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 387ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand add "https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream" took 1 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand play Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand play took 0 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 2ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 1ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 1ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 1ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand status took 38 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand status took 39 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand status took 38 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand status took 38 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand status took 1 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 1 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus stop Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 40ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 4ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand status took 2 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:39 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:39 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":102,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:39 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":481,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:39 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 89ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 88ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 88ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 52ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: Dec 27 07:27:39 volumio-4 volumio[1499]: ---------------------------- MPD announces system playlist update Dec 27 07:27:39 volumio-4 volumio[1499]: info: Ignoring MPD Status Update Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 51ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand status took 50 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 50ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand status took 50 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 49 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:39 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 71ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 sudo[5752]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 sudo[5752]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 sudo[5755]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 sudo[5755]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 sudo[5760]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 sudo[5760]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 sudo[5765]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 sudo[5765]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:39 volumio-4 sudo[5757]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 sudo[5757]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 sudo[5767]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 sudo[5767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 sudo[5770]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 sudo[5764]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 sudo[5770]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 sudo[5764]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:39 volumio-4 sudo[5772]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 volumio[1499]: info: ------------------------------ 130ms Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 129 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 128 milliseconds Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:39 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 sudo[5772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 27 07:27:39 volumio-4 sudo[5777]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:39 volumio-4 sudo[5777]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"32 Kbps","isStreaming":false,"title":"stream","artist":"RADIO MARIA MALTA","album":null,"uri":"https://dreamsiteradiocp2.com/proxy/rmmalta2?mp=/stream","trackType":""} Dec 27 07:27:39 volumio-4 volumio[1499]: verbose: CURRENT POSITION 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState stateService play Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::syncState currentStatus play Dec 27 07:27:39 volumio-4 volumio[1499]: info: Received an update from plugin. extracting info from payload Dec 27 07:27:39 volumio-4 sudo[5752]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:39 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:39 volumio-4 sudo[5760]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:39 volumio-4 sudo[5755]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 volumio[1499]: info: ------------------------------ 213ms Dec 27 07:27:40 volumio-4 volumio[1499]: info: ------------------------------ 214ms Dec 27 07:27:40 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:40 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:40 volumio-4 sudo[5784]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:40 volumio-4 sudo[5784]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:40 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:40 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 27 07:27:40 volumio-4 sudo[5787]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:40 volumio-4 sudo[5787]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:40 volumio-4 sudo[5789]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:40 volumio-4 sudo[5789]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:40 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:40 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:40 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:40 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:40 volumio-4 sudo[5792]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 27 07:27:40 volumio-4 sudo[5792]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: touch_display: Setting screensaver timeout to 0 seconds. Dec 27 07:27:40 volumio-4 sudo[5764]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 sudo[5777]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 sudo[5770]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 sudo[5765]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 sudo[5784]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 sudo[5772]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 sudo[5787]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 sudo[5789]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 sudo[5792]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 sudo[5767]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 sudo[5757]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:40 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Started Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioStop Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreStateMachine::stop Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreStateMachine::stPlaybackTimer Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreStateMachine::updateTrackBlock Dec 27 07:27:41 volumio-4 volumio[1499]: info: CorePlayQueue::getTrackBlock Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:41 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreStateMachine::serviceStop Dec 27 07:27:41 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:41 volumio-4 volumio[1499]: info: CoreCommandRouter::serviceStop Dec 27 07:27:41 volumio-4 volumio[1499]: info: [1766816861989] ControllerWebradio::stop Dec 27 07:27:41 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand stop Dec 27 07:27:41 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:42 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:42 volumio-4 volumio[1499]: info: Dec 27 07:27:42 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:42 volumio-4 volumio[1499]: info: sendMpdCommand stop took 23 milliseconds Dec 27 07:27:42 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:42 volumio-4 volumio[1499]: info: sendMpdCommand status took 1 milliseconds Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:42 volumio-4 sudo[5805]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:42 volumio-4 sudo[5805]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:42 volumio-4 volumio[1499]: info: Dec 27 07:27:42 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:42 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:42 volumio-4 volumio[1499]: info: Dec 27 07:27:42 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:42 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:42 volumio-4 volumio[1499]: info: Dec 27 07:27:42 volumio-4 volumio[1499]: ---------------------------- MPD announces state update: player Dec 27 07:27:42 volumio-4 volumio[1499]: info: ControllerMpd::getState Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand status Dec 27 07:27:42 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 13 milliseconds Dec 27 07:27:42 volumio-4 volumio[1499]: info: sendMpdCommand status took 6 milliseconds Dec 27 07:27:42 volumio-4 volumio[1499]: info: sendMpdCommand status took 4 milliseconds Dec 27 07:27:42 volumio-4 volumio[1499]: info: sendMpdCommand status took 2 milliseconds Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::parseState Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 27 07:27:42 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:42 volumio-4 systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 27 07:27:42 volumio-4 systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 27 07:27:42 volumio-4 systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 27 07:27:42 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:42 volumio-4 volumio[1499]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 27 07:27:42 volumio-4 sudo[5805]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:42 volumio-4 volumio[1499]: info: ------------------------------ 36ms Dec 27 07:27:42 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 27 07:27:42 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 27 07:27:42 volumio-4 volumio[1499]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:42 volumio-4 volumio[1499]: verbose: ControllerMpd::parseTrackInfo Dec 27 07:27:42 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:42 volumio-4 volumio[1499]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 27 07:27:42 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:42 volumio-4 volumio[1499]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 27 07:27:42 volumio-4 volumio[1499]: info: ControllerMpd::pushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreCommandRouter::servicePushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreStateMachine::pushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:42 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioPushState Dec 27 07:27:42 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:42 volumio-4 volumio[1499]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Dec 27 07:27:42 volumio-4 volumio[1499]: info: ------------------------------ 53ms Dec 27 07:27:42 volumio-4 volumio[1499]: info: ------------------------------ 52ms Dec 27 07:27:42 volumio-4 volumio[1499]: info: ------------------------------ 50ms Dec 27 07:27:42 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:42 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:42 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:42 volumio-4 sudo[5810]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:42 volumio-4 sudo[5810]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:42 volumio-4 volumio[1499]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 27 07:27:42 volumio-4 sudo[5812]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:42 volumio-4 sudo[5812]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:42 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:42 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:42 volumio-4 sudo[5815]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:42 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:42 volumio-4 sudo[5815]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:42 volumio-4 volumio[1499]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Dec 27 07:27:42 volumio-4 sudo[5818]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 27 07:27:42 volumio-4 sudo[5818]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 07:27:42 volumio-4 volumio[1499]: info: touch_display: Setting screensaver timeout to 100 seconds. Dec 27 07:27:42 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:42 volumio-4 sudo[5810]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:42 volumio-4 sudo[5818]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:42 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:42 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:42 volumio-4 sudo[5812]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:42 volumio-4 sudo[5815]: pam_unix(sudo:session): session closed for user root Dec 27 07:27:42 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:42 volumio-4 volumio[1499]: info: peppymeterbasic Daemon Stop Dec 27 07:27:44 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioGetState Dec 27 07:27:44 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:49 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:49+01:00" level=trace msg="sent dealer ping" Dec 27 07:27:49 volumio-4 go-librespot[2008]: time="2025-12-27T07:27:49+01:00" level=trace msg="received dealer pong" Dec 27 07:27:54 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Dec 27 07:27:54 volumio-4 volumio[1499]: info: In handleBrowseUri, curUri=spotify Dec 27 07:27:54 volumio-4 volumio[1499]: info: Preload queue cleared Dec 27 07:27:54 volumio-4 volumio[1499]: info: Preload queue cleared Dec 27 07:27:54 volumio-4 volumio[1499]: info: Preload queue cleared Dec 27 07:27:54 volumio-4 volumio[1499]: info: Preload queue cleared Dec 27 07:27:54 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioGetState Dec 27 07:27:54 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:27:54 volumio-4 volumio[1499]: info: Listing playlists Dec 27 07:27:54 volumio-4 volumio[1499]: info: Listing playlists Dec 27 07:28:04 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioGetState Dec 27 07:28:04 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:28:14 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioGetState Dec 27 07:28:14 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:28:14 volumio-4 volumio[1499]: info: Listing playlists Dec 27 07:28:14 volumio-4 volumio[1499]: info: Listing playlists Dec 27 07:28:17 volumio-4 volumio[1499]: Searching plugin music_service/spop Dec 27 07:28:17 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: spop , search Dec 27 07:28:18 volumio-4 volumio[1499]: info: All search sources collected, pushing search results Dec 27 07:28:18 volumio-4 volumio[1499]: Searching plugin music_service/spop Dec 27 07:28:18 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: spop , search Dec 27 07:28:18 volumio-4 go-librespot[2008]: time="2025-12-27T07:28:18+01:00" level=trace msg="received accesspoint ping" Dec 27 07:28:18 volumio-4 go-librespot[2008]: time="2025-12-27T07:28:18+01:00" level=trace msg="received accesspoint pong ack" Dec 27 07:28:19 volumio-4 go-librespot[2008]: time="2025-12-27T07:28:19+01:00" level=trace msg="sent dealer ping" Dec 27 07:28:19 volumio-4 go-librespot[2008]: time="2025-12-27T07:28:19+01:00" level=trace msg="received dealer pong" Dec 27 07:28:19 volumio-4 volumio[1499]: info: All search sources collected, pushing search results Dec 27 07:28:22 volumio-4 volumio[1499]: Searching plugin music_service/spop Dec 27 07:28:22 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: spop , search Dec 27 07:28:23 volumio-4 volumio[1499]: info: All search sources collected, pushing search results Dec 27 07:28:24 volumio-4 volumio[1499]: info: CoreCommandRouter::volumioGetState Dec 27 07:28:24 volumio-4 volumio[1499]: info: CorePlayQueue::getTrack 0 Dec 27 07:28:29 volumio-4 volumio[1499]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Dec 27 07:28:29 volumio-4 volumio[1499]: info: In handleBrowseUri, curUri=spotify:artist:4yRpun4jqbDuWwyQLXLMKM Dec 27 07:28:30 volumio-4 volumio[1499]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 27 07:28:30 volumio-4 volumio[1499]: TypeError: Cannot read properties of undefined (reading 'url') Dec 27 07:28:30 volumio-4 volumio[1499]: at /data/plugins/music_service/spop/index.js:2446:60 Dec 27 07:28:30 volumio-4 volumio[1499]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Dec 27 07:28:30 volumio-4 volumio[1499]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 27 07:28:30 volumio-4 sudo[5977]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-27 07:27' Dec 27 07:28:30 volumio-4 sudo[5977]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"