-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2025-06-24 22:24:54 CEST. -- Jun 24 22:23:09 volumio volumio[1083]: info: Preload queue cleared Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::ClearQueue Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::stop Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::stPlaybackTimer Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::updateTrackBlock Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrackBlock Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::serviceStop Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::serviceStop Jun 24 22:23:09 volumio volumio[1083]: info: ControllerMpd::stop Jun 24 22:23:09 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::clearPlayQueue Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::saveQueue Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::volumioPushQueue Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::addQueueItems Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::addQueueItems Jun 24 22:23:09 volumio volumio[1083]: info: Preload queue cleared Jun 24 22:23:09 volumio volumio[1083]: info: Adding Item to queue: webrns/0 Jun 24 22:23:09 volumio volumio[1083]: info: Using cached record of: webrns/0 Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::volumioPushQueue Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::saveQueue Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::updateTrackBlock Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrackBlock Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::volumioPlay Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::play index 0 Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::stop Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::play index undefined Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::startPlaybackTimer Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:09 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 22:23:09 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status stop Jun 24 22:23:09 volumio volumio[1083]: info: Jun 24 22:23:09 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:09 volumio volumio[1083]: info: sendMpdCommand stop took 130 milliseconds Jun 24 22:23:09 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:09 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:09 volumio volumio[1083]: info: sendMpdCommand stop took 96 milliseconds Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:09 volumio volumio[1083]: verbose: STATE SERVICE {"status":"stop"} Jun 24 22:23:09 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:09 volumio volumio[1083]: info: No code Jun 24 22:23:09 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:09 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:09 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:09 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand clear Jun 24 22:23:09 volumio volumio[1083]: info: Jun 24 22:23:09 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:09 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:09 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:09 volumio volumio[1083]: info: Jun 24 22:23:09 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:09 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:09 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:09 volumio volumio[1083]: info: Jun 24 22:23:09 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:09 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:09 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:09 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status stop Jun 24 22:23:09 volumio sudo[9183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 24 22:23:09 volumio sudo[9183]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:09 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status stop Jun 24 22:23:09 volumio systemd[1]: Stopping peppymeterbasic Daemon... Jun 24 22:23:09 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Jun 24 22:23:09 volumio sudo[9188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 24 22:23:09 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status stop Jun 24 22:23:09 volumio sudo[9188]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:09 volumio sudo[9190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 24 22:23:09 volumio sudo[9190]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:09 volumio systemd[1]: peppymeterbasic.service: Succeeded. Jun 24 22:23:09 volumio systemd[1]: Stopped peppymeterbasic Daemon. Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand status took 300 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand clear took 257 milliseconds Jun 24 22:23:10 volumio sudo[9194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand status took 223 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand status took 222 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand status took 219 milliseconds Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:10 volumio sudo[9194]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rad357pl Received mpd Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio sudo[9183]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio volumio[1083]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rad357pl Received mpd Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rad357pl Received mpd Jun 24 22:23:10 volumio sudo[9188]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio sudo[9190]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 357ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 361ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 358ms Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio sudo[9194]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: Preload queue cleared Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::ClearQueue Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::clearPlayQueue Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::saveQueue Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushQueue Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::addQueueItems Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::addQueueItems Jun 24 22:23:10 volumio volumio[1083]: info: Preload queue cleared Jun 24 22:23:10 volumio volumio[1083]: info: Adding Item to queue: webrns/0 Jun 24 22:23:10 volumio volumio[1083]: info: Using cached record of: webrns/0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushQueue Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::saveQueue Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::updateTrackBlock Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrackBlock Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPlay Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::play index 0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::play index undefined Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::startPlaybackTimer Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status stop Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status stop Jun 24 22:23:10 volumio sudo[9197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 24 22:23:10 volumio sudo[9197]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status stop Jun 24 22:23:10 volumio sudo[9200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 24 22:23:10 volumio sudo[9200]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio sudo[9197]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio volumio[1083]: error: updateQueue error: null Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 353ms Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 341 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" took 342 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 205ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 199ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 184ms Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand stop took 151 milliseconds Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand play Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand clear Jun 24 22:23:10 volumio volumio[1083]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 24 22:23:10 volumio sudo[9203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 668ms Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio sudo[9203]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio sudo[9200]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio volumio[1083]: info: peppymeterbasic Daemon Stop Jun 24 22:23:10 volumio volumio[1083]: info: peppymeterbasic Daemon Stop Jun 24 22:23:10 volumio volumio[1083]: info: peppymeterbasic Daemon Stop Jun 24 22:23:10 volumio volumio[1083]: info: peppymeterbasic Daemon Stop Jun 24 22:23:10 volumio volumio[1083]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 24 22:23:10 volumio volumio[1083]: error: updateQueue error: null Jun 24 22:23:10 volumio volumio[1083]: error: updateQueue error: null Jun 24 22:23:10 volumio volumio[1083]: error: updateQueue error: null Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 69ms Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand play took 55 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand clear took 54 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 51ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 50ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 48ms Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:10 volumio volumio[1083]: info: peppymeterbasic Daemon Stop Jun 24 22:23:10 volumio volumio[1083]: info: peppymeterbasic Daemon Stop Jun 24 22:23:10 volumio volumio[1083]: error: updateQueue error: null Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 29ms Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand status took 25 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" took 24 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 23ms Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand status took 21 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 19ms Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand status took 18 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 17ms Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand status took 15 milliseconds Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:10 volumio sudo[9203]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand play Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:10 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 24 22:23:10 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: No code Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 24 22:23:10 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: No code Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 24 22:23:10 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: No code Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:10 volumio volumio[1083]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 24 22:23:10 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: No code Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:10 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 119ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 143ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 140ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 157ms Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: Jun 24 22:23:10 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:10 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 159ms Jun 24 22:23:10 volumio volumio[1083]: info: sendMpdCommand play took 141 milliseconds Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 9ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 7ms Jun 24 22:23:10 volumio volumio[1083]: info: ------------------------------ 5ms Jun 24 22:23:10 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:10 volumio sudo[9207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:10 volumio sudo[9207]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:10 volumio sudo[9209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:10 volumio sudo[9211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:10 volumio sudo[9211]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio sudo[9209]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:10 volumio systemd[1]: Started peppymeterbasic Daemon. Jun 24 22:23:10 volumio sudo[9216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:10 volumio sudo[9216]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio sudo[9219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:10 volumio sudo[9219]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio sudo[9207]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:10 volumio sudo[9224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:10 volumio sudo[9224]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:10 volumio sudo[9209]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio sudo[9211]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:10 volumio sudo[9227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:10 volumio sudo[9227]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:10 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:10 volumio sudo[9224]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio sudo[9216]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio sudo[9219]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio sudo[9230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9230]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio sudo[9227]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio sudo[9232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9232]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio sudo[9230]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio sudo[9235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9235]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio sudo[9239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9239]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio sudo[9232]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio sudo[9235]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio sudo[9241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9241]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio volumio[1083]: info: peppymeterbasic Daemon Stop Jun 24 22:23:11 volumio sudo[9239]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:11 volumio sudo[9241]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:11 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:11 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:11 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:11 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand status took 28 milliseconds Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:11 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand status took 31 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand status took 29 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand status took 27 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:11 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:11 volumio volumio[1083]: 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":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:11 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Jun 24 22:23:11 volumio volumio[1083]: info: ------------------------------ 46ms Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:11 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:11 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:11 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:11 volumio volumio[1083]: info: Jun 24 22:23:11 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:11 volumio volumio[1083]: info: ------------------------------ 26ms Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand status took 25 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 21 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 22 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: ------------------------------ 17ms Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:11 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:11 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:11 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:11 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:11 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:11 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:11 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:11 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:11 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:11 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:11 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:11 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: ------------------------------ 136ms Jun 24 22:23:11 volumio volumio[1083]: info: ------------------------------ 134ms Jun 24 22:23:11 volumio volumio[1083]: info: ------------------------------ 134ms Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand status took 97 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: ------------------------------ 97ms Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand status took 96 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: ------------------------------ 95ms Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand status took 99 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 90 milliseconds Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:11 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:11 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:11 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:11 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: ------------------------------ 169ms Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio sudo[9248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9248]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio sudo[9250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9250]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio sudo[9254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9254]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio sudo[9248]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio sudo[9250]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio sudo[9256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9256]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio sudo[9254]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio sudo[9256]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio sudo[9260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9260]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:11 volumio sudo[9262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9262]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio sudo[9265]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio sudo[9260]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio sudo[9269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:11 volumio sudo[9269]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:11 volumio sudo[9265]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 432 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 432 milliseconds Jun 24 22:23:11 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 433 milliseconds Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:11 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:11 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:11 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:11 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:11 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio sudo[9262]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:11 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:11 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:11 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:11 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio sudo[9269]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:11 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:11 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:11 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:11 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:11 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:11 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:12 volumio volumio[1083]: info: ------------------------------ 605ms Jun 24 22:23:12 volumio volumio[1083]: info: ------------------------------ 603ms Jun 24 22:23:12 volumio volumio[1083]: info: ------------------------------ 601ms Jun 24 22:23:12 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:12 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:12 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:12 volumio sudo[9274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:12 volumio sudo[9274]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:12 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:12 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:12 volumio sudo[9274]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:12 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:12 volumio sudo[9279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:12 volumio sudo[9279]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:12 volumio sudo[9276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:12 volumio sudo[9276]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:12 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:12 volumio sudo[9281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:12 volumio sudo[9281]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:12 volumio sudo[9276]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:12 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:12 volumio sudo[9288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:12 volumio sudo[9288]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:12 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:12 volumio sudo[9281]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:12 volumio sudo[9279]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:12 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:12 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:12 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:12 volumio sudo[9285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:12 volumio sudo[9285]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:12 volumio sudo[9288]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:12 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:12 volumio sudo[9285]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:12 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:13 volumio volumio[9218]: libpng warning: iCCP: known incorrect sRGB profile Jun 24 22:23:13 volumio volumio[9218]: libpng warning: iCCP: known incorrect sRGB profile Jun 24 22:23:19 volumio volumio[1083]: info: VolumeController::SetAlsaVolume31 Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:19 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:19 volumio volumio[1083]: info: Jun 24 22:23:19 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:19 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:19 volumio volumio[1083]: info: Jun 24 22:23:19 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:19 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:19 volumio volumio[1083]: info: Jun 24 22:23:19 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:19 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:19 volumio volumio[1083]: info: Jun 24 22:23:19 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:19 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:19 volumio volumio[1083]: info: sendMpdCommand status took 16 milliseconds Jun 24 22:23:19 volumio volumio[1083]: info: sendMpdCommand status took 13 milliseconds Jun 24 22:23:19 volumio volumio[1083]: info: sendMpdCommand status took 9 milliseconds Jun 24 22:23:19 volumio volumio[1083]: info: sendMpdCommand status took 6 milliseconds Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:19 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 9 milliseconds Jun 24 22:23:19 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 9 milliseconds Jun 24 22:23:19 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 10 milliseconds Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:19 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:19 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:19 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:19 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9359,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:19 volumio sudo[9327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:19 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:19 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:19 volumio sudo[9327]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:19 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:19 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:19 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9359,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:19 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:19 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:19 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:19 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:19 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9359,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:19 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:19 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:19 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:19 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:19 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":9359,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:19 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:19 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:19 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:19 volumio sudo[9327]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:19 volumio volumio[1083]: info: ------------------------------ 128ms Jun 24 22:23:19 volumio volumio[1083]: info: ------------------------------ 125ms Jun 24 22:23:19 volumio volumio[1083]: info: ------------------------------ 122ms Jun 24 22:23:19 volumio volumio[1083]: info: ------------------------------ 118ms Jun 24 22:23:19 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:20 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:20 volumio sudo[9332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:20 volumio sudo[9332]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:20 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:20 volumio sudo[9332]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:20 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:20 volumio sudo[9335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:20 volumio sudo[9335]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:20 volumio sudo[9337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:20 volumio sudo[9337]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:20 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:20 volumio sudo[9335]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:20 volumio sudo[9340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:20 volumio sudo[9340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:20 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:20 volumio sudo[9337]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:20 volumio sudo[9344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:20 volumio sudo[9344]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:20 volumio sudo[9340]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:20 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:20 volumio sudo[9347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:20 volumio sudo[9347]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:20 volumio sudo[9344]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:20 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:20 volumio sudo[9350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:20 volumio sudo[9350]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:20 volumio sudo[9347]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:20 volumio sudo[9353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:20 volumio sudo[9353]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:20 volumio sudo[9350]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:20 volumio sudo[9353]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:20 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:21 volumio volumio[1083]: info: VolumeController::SetAlsaVolume47 Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:21 volumio volumio[1083]: info: Jun 24 22:23:21 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:21 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:21 volumio volumio[1083]: info: Jun 24 22:23:21 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:21 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:21 volumio volumio[1083]: info: Jun 24 22:23:21 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:21 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:21 volumio volumio[1083]: info: Jun 24 22:23:21 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:21 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:21 volumio volumio[1083]: info: sendMpdCommand status took 18 milliseconds Jun 24 22:23:21 volumio volumio[1083]: info: sendMpdCommand status took 15 milliseconds Jun 24 22:23:21 volumio volumio[1083]: info: sendMpdCommand status took 12 milliseconds Jun 24 22:23:21 volumio volumio[1083]: info: sendMpdCommand status took 9 milliseconds Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:21 volumio sudo[9361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:21 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 24 22:23:21 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 24 22:23:21 volumio sudo[9361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:21 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 24 22:23:21 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:21 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:21 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:21 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11109,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:21 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:21 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:21 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:21 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:21 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11109,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:21 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:21 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:21 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:21 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:21 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11109,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:21 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:21 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:21 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:21 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:21 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11109,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:21 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:21 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:21 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:21 volumio sudo[9361]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:21 volumio volumio[1083]: info: ------------------------------ 106ms Jun 24 22:23:21 volumio volumio[1083]: info: ------------------------------ 103ms Jun 24 22:23:21 volumio volumio[1083]: info: ------------------------------ 102ms Jun 24 22:23:21 volumio volumio[1083]: info: ------------------------------ 98ms Jun 24 22:23:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:21 volumio sudo[9367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:21 volumio sudo[9367]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:21 volumio sudo[9367]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:21 volumio sudo[9372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:21 volumio sudo[9372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:21 volumio sudo[9370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:21 volumio sudo[9370]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:21 volumio sudo[9375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:21 volumio sudo[9375]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:21 volumio sudo[9378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:21 volumio sudo[9378]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:21 volumio sudo[9370]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:21 volumio sudo[9372]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:21 volumio sudo[9382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:21 volumio sudo[9382]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:21 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:21 volumio sudo[9375]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:21 volumio sudo[9385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:21 volumio sudo[9385]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:21 volumio sudo[9378]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio sudo[9382]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio sudo[9388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio sudo[9388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio sudo[9385]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio sudo[9388]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio volumio[1083]: info: VolumeController::SetAlsaVolume46 Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:22 volumio volumio[1083]: info: Jun 24 22:23:22 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:22 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:22 volumio volumio[1083]: info: Jun 24 22:23:22 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:22 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:22 volumio volumio[1083]: info: Jun 24 22:23:22 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:22 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:22 volumio volumio[1083]: info: Jun 24 22:23:22 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:22 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:22 volumio volumio[1083]: info: sendMpdCommand status took 14 milliseconds Jun 24 22:23:22 volumio volumio[1083]: info: sendMpdCommand status took 12 milliseconds Jun 24 22:23:22 volumio volumio[1083]: info: sendMpdCommand status took 8 milliseconds Jun 24 22:23:22 volumio volumio[1083]: info: sendMpdCommand status took 6 milliseconds Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:22 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 17 milliseconds Jun 24 22:23:22 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 17 milliseconds Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:22 volumio sudo[9392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:22 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:22 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:22 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11976,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:22 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:22 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio sudo[9392]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:22 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:22 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11976,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:22 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:22 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:22 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:22 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11976,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:22 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:22 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:22 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:22 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11976,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:22 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:22 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio sudo[9392]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio volumio[1083]: info: ------------------------------ 124ms Jun 24 22:23:22 volumio volumio[1083]: info: ------------------------------ 122ms Jun 24 22:23:22 volumio volumio[1083]: info: ------------------------------ 121ms Jun 24 22:23:22 volumio volumio[1083]: info: ------------------------------ 118ms Jun 24 22:23:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:22 volumio sudo[9397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio sudo[9397]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:22 volumio sudo[9399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio sudo[9399]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:22 volumio sudo[9397]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio sudo[9399]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:22 volumio sudo[9405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio sudo[9405]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio sudo[9403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio sudo[9403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:22 volumio sudo[9407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio sudo[9407]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:22 volumio sudo[9410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio sudo[9410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio sudo[9405]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio sudo[9403]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio sudo[9414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio sudo[9414]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio sudo[9407]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio sudo[9418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:22 volumio sudo[9410]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio sudo[9418]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:22 volumio volumio[1083]: info: VolumeController::SetAlsaVolume44 Jun 24 22:23:22 volumio sudo[9414]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio volumio[1083]: info: VolumeController::SetAlsaVolume43 Jun 24 22:23:22 volumio sudo[9418]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:22 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:22 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9423]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio volumio[1083]: info: Jun 24 22:23:23 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:23 volumio sudo[9426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9426]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio sudo[9423]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio volumio[1083]: info: Jun 24 22:23:23 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:23 volumio volumio[1083]: info: Jun 24 22:23:23 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:23 volumio volumio[1083]: info: Jun 24 22:23:23 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:23 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:23 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:23 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:23 volumio volumio[1083]: info: Jun 24 22:23:23 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:23 volumio sudo[9426]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand status took 62 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand status took 37 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand status took 20 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand status took 22 milliseconds Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:23 volumio volumio[1083]: info: Jun 24 22:23:23 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:23 volumio volumio[1083]: info: Jun 24 22:23:23 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:23 volumio volumio[1083]: info: Jun 24 22:23:23 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:23 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand status took 26 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 19 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 19 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 18 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 18 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand status took 15 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand status took 14 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand status took 13 milliseconds Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:23 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:23 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12605,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:23 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:23 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:23 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:23 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12605,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:23 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:23 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:23 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:23 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12605,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:23 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:23 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:23 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:23 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12605,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:23 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:23 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: ------------------------------ 141ms Jun 24 22:23:23 volumio volumio[1083]: info: ------------------------------ 126ms Jun 24 22:23:23 volumio volumio[1083]: info: ------------------------------ 114ms Jun 24 22:23:23 volumio volumio[1083]: info: ------------------------------ 98ms Jun 24 22:23:23 volumio volumio[1083]: info: VolumeController::SetAlsaVolume42 Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 120 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 120 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 120 milliseconds Jun 24 22:23:23 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 120 milliseconds Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:23 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:23 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:23 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:23 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:23 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:23 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:23 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:23 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:23 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:23 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:23 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:23 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:23 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:23 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:23 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:23 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:23 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:23 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:23 volumio volumio[1083]: info: ------------------------------ 208ms Jun 24 22:23:23 volumio volumio[1083]: info: ------------------------------ 195ms Jun 24 22:23:23 volumio volumio[1083]: info: ------------------------------ 194ms Jun 24 22:23:23 volumio volumio[1083]: info: ------------------------------ 194ms Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9430]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9430]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9433]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio sudo[9435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9435]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9439]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio sudo[9433]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9435]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio sudo[9442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9442]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9442]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio sudo[9445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9445]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio sudo[9439]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9445]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio sudo[9448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9448]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9451]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio sudo[9448]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9454]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio sudo[9451]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9456]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9454]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio sudo[9460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9460]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio sudo[9462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9462]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9456]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio sudo[9460]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio sudo[9466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9466]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio sudo[9462]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9468]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:23 volumio sudo[9466]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:23 volumio sudo[9472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:23 volumio sudo[9472]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:23 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:24 volumio sudo[9475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9475]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio sudo[9468]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio sudo[9472]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio sudo[9478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9478]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio sudo[9475]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio volumio[1083]: info: Jun 24 22:23:24 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:24 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:24 volumio sudo[9478]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio volumio[1083]: info: Jun 24 22:23:24 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:24 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:24 volumio volumio[1083]: info: Jun 24 22:23:24 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:24 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:24 volumio volumio[1083]: info: Jun 24 22:23:24 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:24 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: sendMpdCommand status took 26 milliseconds Jun 24 22:23:24 volumio volumio[1083]: info: sendMpdCommand status took 22 milliseconds Jun 24 22:23:24 volumio volumio[1083]: info: sendMpdCommand status took 22 milliseconds Jun 24 22:23:24 volumio volumio[1083]: info: sendMpdCommand status took 19 milliseconds Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 24 22:23:24 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 24 22:23:24 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 24 22:23:24 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 8 milliseconds Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:24 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:24 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:24 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:24 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13610,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:24 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:24 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:24 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:24 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:24 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13610,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:24 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:24 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:24 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:24 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:24 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13610,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:24 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:24 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:24 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:24 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:24 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":13610,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:24 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:24 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:24 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:24 volumio volumio[1083]: info: ------------------------------ 96ms Jun 24 22:23:24 volumio volumio[1083]: info: ------------------------------ 92ms Jun 24 22:23:24 volumio volumio[1083]: info: ------------------------------ 92ms Jun 24 22:23:24 volumio volumio[1083]: info: ------------------------------ 91ms Jun 24 22:23:24 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:24 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:24 volumio sudo[9483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9483]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:24 volumio sudo[9486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9486]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:24 volumio sudo[9483]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio sudo[9488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9488]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:24 volumio sudo[9486]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio sudo[9492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9492]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:24 volumio sudo[9494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9494]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio sudo[9488]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:24 volumio sudo[9498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9498]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status play Jun 24 22:23:24 volumio sudo[9494]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio sudo[9492]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio sudo[9501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9501]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio sudo[9503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jun 24 22:23:24 volumio sudo[9503]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio sudo[9498]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio sudo[9501]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:24 volumio sudo[9503]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:24 volumio volumio[1083]: info: peppymeterbasic Daemon Started Jun 24 22:23:31 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Jun 24 22:23:32 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 24 22:23:32 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 24 22:23:35 volumio volumio[1083]: info: Stopping peppymeterbasic service Jun 24 22:23:35 volumio volumio[1083]: info: CoreStateMachine::stop Jun 24 22:23:35 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:35 volumio volumio[1083]: info: CoreStateMachine::stPlaybackTimer Jun 24 22:23:35 volumio volumio[1083]: info: CoreStateMachine::updateTrackBlock Jun 24 22:23:35 volumio volumio[1083]: info: CorePlayQueue::getTrackBlock Jun 24 22:23:35 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:35 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:35 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:35 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:35 volumio volumio[1083]: info: CoreStateMachine::serviceStop Jun 24 22:23:35 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:35 volumio volumio[1083]: info: CoreCommandRouter::serviceStop Jun 24 22:23:35 volumio volumio[1083]: info: ControllerMpd::stop Jun 24 22:23:35 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 22:23:35 volumio volumio[1083]: info: Disabling plugin peppymeterbasic Jun 24 22:23:35 volumio volumio[1083]: info: Preparing to generate the ALSA configuration file Jun 24 22:23:35 volumio volumio[1083]: info: PeppyMeterBasic ---peppymeterbasic status stop Jun 24 22:23:36 volumio volumio[1083]: info: Jun 24 22:23:36 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:36 volumio volumio[1083]: info: sendMpdCommand stop took 179 milliseconds Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:36 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: verbose: STATE SERVICE {"status":"stop"} Jun 24 22:23:36 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:36 volumio volumio[1083]: info: CoreStateMachine::syncState stateService stop Jun 24 22:23:36 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Jun 24 22:23:36 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:36 volumio volumio[1083]: info: No code Jun 24 22:23:36 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:36 volumio sudo[9565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 24 22:23:36 volumio sudo[9565]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:36 volumio systemd[1]: Stopping peppymeterbasic Daemon... Jun 24 22:23:36 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Jun 24 22:23:36 volumio volumio[1083]: info: Jun 24 22:23:36 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:36 volumio volumio[1083]: info: Jun 24 22:23:36 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:36 volumio volumio[1083]: info: Jun 24 22:23:36 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:36 volumio sudo[9568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jun 24 22:23:36 volumio sudo[9568]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:36 volumio volumio[1083]: info: sendMpdCommand status took 128 milliseconds Jun 24 22:23:36 volumio volumio[1083]: info: sendMpdCommand status took 37 milliseconds Jun 24 22:23:36 volumio volumio[1083]: info: sendMpdCommand status took 34 milliseconds Jun 24 22:23:36 volumio volumio[1083]: info: sendMpdCommand status took 30 milliseconds Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:36 volumio systemd[1]: peppymeterbasic.service: Succeeded. Jun 24 22:23:36 volumio systemd[1]: Stopped peppymeterbasic Daemon. Jun 24 22:23:36 volumio sudo[9565]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:36 volumio sudo[9568]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:36 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 127 milliseconds Jun 24 22:23:36 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 124 milliseconds Jun 24 22:23:36 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 110 milliseconds Jun 24 22:23:36 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 112 milliseconds Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:36 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rad357pl Received mpd Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:36 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rad357pl Received mpd Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:36 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rad357pl Received mpd Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:36 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:36 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:36 volumio volumio[1083]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rad357pl Received mpd Jun 24 22:23:36 volumio volumio[1083]: info: ------------------------------ 356ms Jun 24 22:23:36 volumio volumio[1083]: info: ------------------------------ 269ms Jun 24 22:23:36 volumio volumio[1083]: info: ------------------------------ 264ms Jun 24 22:23:36 volumio volumio[1083]: info: ------------------------------ 259ms Jun 24 22:23:36 volumio volumio[1083]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 24 22:23:36 volumio volumio[1083]: info: peppymeterbasic Daemon Stop Jun 24 22:23:36 volumio volumio[1083]: info: Asound.conf file written Jun 24 22:23:36 volumio sudo[9575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 24 22:23:36 volumio sudo[9575]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:36 volumio sudo[9575]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:36 volumio volumio[1083]: info: Output device has changed, restarting MPD Jun 24 22:23:36 volumio sudo[9581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 24 22:23:36 volumio sudo[9581]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:36 volumio volumio[1083]: info: Output device has changed, restarting Shairport Sync Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 22:23:36 volumio sudo[9581]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:36 volumio sudo[9583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 24 22:23:36 volumio sudo[9583]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:36 volumio systemd[1]: Stopping Music Player Daemon... Jun 24 22:23:36 volumio volumio[1083]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 24 22:23:36 volumio volumio[1083]: info: Done. Jun 24 22:23:36 volumio volumio[1083]: info: Jun 24 22:23:36 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:36 volumio volumio[1083]: error: MPD error: Error: write EPIPE Jun 24 22:23:36 volumio volumio[1083]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Jun 24 22:23:36 volumio volumio[1083]: info: Jun 24 22:23:36 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:36 volumio volumio[1083]: error: MPD error: Error: write EPIPE Jun 24 22:23:36 volumio volumio[1083]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Jun 24 22:23:36 volumio volumio[1083]: info: Jun 24 22:23:36 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:36 volumio volumio[1083]: error: MPD error: Error: write EPIPE Jun 24 22:23:36 volumio volumio[1083]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Jun 24 22:23:36 volumio volumio[1083]: info: Jun 24 22:23:36 volumio volumio[1083]: ---------------------------- MPD announces state update: mixer Jun 24 22:23:36 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:36 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:36 volumio volumio[1083]: error: MPD error: Error: write EPIPE Jun 24 22:23:36 volumio volumio[1083]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Jun 24 22:23:36 volumio volumio[1083]: info: MPD Permissions set Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 24 22:23:36 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 24 22:23:36 volumio systemd[1]: mpd.service: Succeeded. Jun 24 22:23:36 volumio systemd[1]: Stopped Music Player Daemon. Jun 24 22:23:36 volumio volumio[1083]: info: Starting Shairport Sync Jun 24 22:23:36 volumio systemd[1]: Starting Music Player Daemon... Jun 24 22:23:36 volumio sudo[9597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 24 22:23:36 volumio sudo[9597]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:37 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 24 22:23:37 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 24 22:23:37 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 24 22:23:37 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 24 22:23:37 volumio sudo[9597]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:37 volumio volumio[1083]: info: Shairport-Sync Started Jun 24 22:23:37 volumio sudo[9593]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 24 22:23:37 volumio sudo[9593]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 24 22:23:37 volumio sudo[9593]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:37 volumio volumio[1083]: error: Upnp client error: Error: This socket has been ended by the other party Jun 24 22:23:39 volumio mpd[9601]: Jun 24 22:23 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 24 22:23:39 volumio systemd[1]: Started Music Player Daemon. Jun 24 22:23:39 volumio sudo[9583]: pam_unix(sudo:session): session closed for user root Jun 24 22:23:39 volumio volumio[1083]: error: updateQueue error: null Jun 24 22:23:41 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Jun 24 22:23:41 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:42 volumio volumio[1083]: info: CoreCommandRouter::volumioPlay Jun 24 22:23:42 volumio volumio[1083]: info: CoreStateMachine::play index undefined Jun 24 22:23:42 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 24 22:23:42 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:42 volumio volumio[1083]: info: CoreStateMachine::startPlaybackTimer Jun 24 22:23:42 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:42 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand stop Jun 24 22:23:42 volumio volumio[1083]: info: sendMpdCommand stop took 1 milliseconds Jun 24 22:23:42 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand clear Jun 24 22:23:42 volumio volumio[1083]: info: Jun 24 22:23:42 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:42 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:42 volumio volumio[1083]: info: sendMpdCommand clear took 1 milliseconds Jun 24 22:23:42 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" Jun 24 22:23:42 volumio volumio[1083]: error: updateQueue error: null Jun 24 22:23:42 volumio volumio[1083]: info: Jun 24 22:23:42 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:42 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:42 volumio volumio[1083]: info: ------------------------------ 3ms Jun 24 22:23:42 volumio volumio[1083]: info: sendMpdCommand add "http://stream.rcs.revma.com/ye5kghkgcm0uv" took 3 milliseconds Jun 24 22:23:42 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand play Jun 24 22:23:42 volumio volumio[1083]: info: ------------------------------ 6ms Jun 24 22:23:42 volumio volumio[1083]: info: sendMpdCommand play took 7 milliseconds Jun 24 22:23:42 volumio volumio[1083]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 24 22:23:44 volumio volumio[1083]: info: Jun 24 22:23:44 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:44 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:44 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:44 volumio volumio[1083]: info: Jun 24 22:23:44 volumio volumio[1083]: ---------------------------- MPD announces system playlist update Jun 24 22:23:44 volumio volumio[1083]: info: Ignoring MPD Status Update Jun 24 22:23:44 volumio volumio[1083]: info: Jun 24 22:23:44 volumio volumio[1083]: ---------------------------- MPD announces state update: player Jun 24 22:23:44 volumio volumio[1083]: info: sendMpdCommand status took 25 milliseconds Jun 24 22:23:44 volumio volumio[1083]: info: ControllerMpd::getState Jun 24 22:23:44 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand status Jun 24 22:23:44 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:44 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:44 volumio volumio[1083]: info: ------------------------------ 11ms Jun 24 22:23:44 volumio volumio[1083]: info: sendMpdCommand status took 16 milliseconds Jun 24 22:23:44 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 24 22:23:44 volumio volumio[1083]: verbose: ControllerMpd::parseState Jun 24 22:23:44 volumio volumio[1083]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 24 22:23:44 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:44 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:44 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:44 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:44 volumio volumio[1083]: 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":"129 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:44 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:44 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:44 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus stop Jun 24 22:23:44 volumio volumio[1083]: info: ------------------------------ 67ms Jun 24 22:23:44 volumio volumio[1083]: info: sendMpdCommand playlistinfo took 20 milliseconds Jun 24 22:23:44 volumio volumio[1083]: verbose: ControllerMpd::parseTrackInfo Jun 24 22:23:44 volumio volumio[1083]: info: ControllerMpd::pushState Jun 24 22:23:44 volumio volumio[1083]: info: CoreCommandRouter::servicePushState Jun 24 22:23:44 volumio volumio[1083]: info: CorePlayQueue::getTrack 0 Jun 24 22:23:44 volumio volumio[1083]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"129 Kbps","isStreaming":false,"title":"The Gathering - Strange Machines","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""} Jun 24 22:23:44 volumio volumio[1083]: verbose: CURRENT POSITION 0 Jun 24 22:23:44 volumio volumio[1083]: info: CoreStateMachine::syncState stateService play Jun 24 22:23:44 volumio volumio[1083]: info: CoreStateMachine::syncState currentStatus play Jun 24 22:23:44 volumio volumio[1083]: info: Received an update from plugin. extracting info from payload Jun 24 22:23:44 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:44 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 24 22:23:44 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:44 volumio volumio[1083]: info: CoreStateMachine::pushState Jun 24 22:23:44 volumio volumio[1083]: info: CoreCommandRouter::volumioPushState Jun 24 22:23:44 volumio volumio[1083]: info: ------------------------------ 84ms Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 24 22:24:17 volumio volumio[1083]: info: Retrieving Cloud Streaming UI Jun 24 22:24:17 volumio volumio[1083]: info: Getting Tidal Cloud Configuration Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 24 22:24:17 volumio volumio[1083]: info: Getting Qobuz Cloud Configuration Jun 24 22:24:17 volumio volumio[1083]: info: Asking plugin for UI Config Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 24 22:24:17 volumio volumio[1083]: info: Getting Spotify Cloud Configuration Jun 24 22:24:17 volumio volumio[1083]: info: Asking plugin for UI Config Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 24 22:24:17 volumio volumio[1083]: info: Saving Spotify Acccount Jun 24 22:24:17 volumio volumio[1083]: info: Got Tidal Cloud Configuration Jun 24 22:24:17 volumio volumio[1083]: info: Got it Jun 24 22:24:17 volumio volumio[1083]: info: Got it Jun 24 22:24:17 volumio volumio[1083]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 24 22:24:17 volumio volumio[1083]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::volumioGetBrowseSources Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::volumioGetBrowseSources Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::volumioGetBrowseSources Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 24 22:24:17 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 24 22:24:21 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 24 22:24:25 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 24 22:24:29 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 24 22:24:33 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 24 22:24:34 volumio volumio[1083]: info: CoreCommandRouter::volumioGetState Jun 24 22:24:48 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 24 22:24:48 volumio volumio[1083]: info: Preload queue cleared Jun 24 22:24:49 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 24 22:24:50 volumio volumio[1083]: info: Preload queue cleared Jun 24 22:24:52 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 24 22:24:52 volumio volumio[1083]: info: Preload queue cleared Jun 24 22:24:53 volumio volumio[1083]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jun 24 22:24:53 volumio volumio[1083]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 22:24:53 volumio volumio[1083]: TypeError: Cannot read property 'length' of undefined Jun 24 22:24:53 volumio volumio[1083]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Jun 24 22:24:53 volumio volumio[1083]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Jun 24 22:24:53 volumio volumio[1083]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Jun 24 22:24:53 volumio volumio[1083]: at Parser.emit (events.js:315:20) Jun 24 22:24:53 volumio volumio[1083]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Jun 24 22:24:53 volumio volumio[1083]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Jun 24 22:24:53 volumio volumio[1083]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Jun 24 22:24:53 volumio volumio[1083]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Jun 24 22:24:53 volumio volumio[1083]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Jun 24 22:24:53 volumio volumio[1083]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Jun 24 22:24:53 volumio volumio[1083]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Jun 24 22:24:53 volumio volumio[1083]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Jun 24 22:24:53 volumio volumio[1083]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Jun 24 22:24:53 volumio volumio[1083]: at IncomingMessage.emit (events.js:327:22) Jun 24 22:24:53 volumio volumio[1083]: at endReadableNT (internal/streams/readable.js:1327:12) Jun 24 22:24:53 volumio volumio[1083]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 24 22:24:53 volumio volumio[1083]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 24 22:24:54 volumio sudo[9804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-24 22:23 Jun 24 22:24:54 volumio sudo[9804]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"