-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2024-08-18 17:35:31 CEST. -- Aug 18 17:34:02 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:02 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:02 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:02 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:02 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:02 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:02 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:02 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:02 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:03 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:03 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:03 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:03 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:03 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:03 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:03 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:03 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:05 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:05 home-player volumio[1181]: info: MRS: Updating multiroomSync output Aug 18 17:34:37 home-player volumiologrotate[913]: ls: cannot access '/var/log/samba/log.wb-HOME': No such file or directory Aug 18 17:34:37 home-player volumiologrotate[913]: ls: cannot access 'PLAYER': No such file or directory Aug 18 17:34:58 home-player volumio[1181]: info: CoreCommandRouter::volumioPlay Aug 18 17:34:58 home-player volumio[1181]: verbose: UNSET VOLATILE: Service: smart_inputs Aug 18 17:34:58 home-player volumio[1181]: info: Disabiling Audio Input 5 Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::play index 2 Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::stop Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::stPlaybackTimer Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::updateTrackBlock Aug 18 17:34:58 home-player volumio[1181]: info: CorePlayQueue::getTrackBlock Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:58 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:58 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 17:34:58 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:58 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:58 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::serviceStop Aug 18 17:34:58 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:58 home-player volumio[1181]: info: CoreCommandRouter::serviceStop Aug 18 17:34:58 home-player volumio[1181]: info: [1723995298230] ControllerWebradio::stop Aug 18 17:34:58 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Aug 18 17:34:58 home-player sudo[3339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop audioinput.service Aug 18 17:34:58 home-player sudo[3339]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:34:58 home-player volumio[1181]: info: sendMpdCommand stop took 13 milliseconds Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::play index undefined Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 17:34:58 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:58 home-player volumio[1181]: info: CoreStateMachine::startPlaybackTimer Aug 18 17:34:58 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:58 home-player volumio[1181]: info: [1723995298244] ControllerWebradio::clearAddPlayTrack Aug 18 17:34:58 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Aug 18 17:34:58 home-player systemd[1]: Stopping Audio Input Service... Aug 18 17:34:58 home-player volumio[1181]: info: sendMpdCommand stop took 1 milliseconds Aug 18 17:34:58 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand clear Aug 18 17:34:58 home-player systemd[1]: audioinput.service: Main process exited, code=killed, status=15/TERM Aug 18 17:34:58 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:34:58 home-player volumio[1181]: info: Aug 18 17:34:58 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:58 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:58 home-player volumio[1181]: info: sendMpdCommand clear took 14 milliseconds Aug 18 17:34:58 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand load "https://eu10.fastcast4u.com:8120" Aug 18 17:34:58 home-player volumio[1181]: info: Aug 18 17:34:58 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:58 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:58 home-player volumio[1181]: info: Aug 18 17:34:58 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:58 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:58 home-player volumio[1181]: info: Aug 18 17:34:58 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:58 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:58 home-player volumio[1181]: error: updateQueue error: null Aug 18 17:34:58 home-player volumio[1181]: info: ------------------------------ 3ms Aug 18 17:34:58 home-player volumio[1181]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 18 17:34:58 home-player systemd[1]: audioinput.service: Succeeded. Aug 18 17:34:58 home-player systemd[1]: Stopped Audio Input Service. Aug 18 17:34:58 home-player sudo[3339]: pam_unix(sudo:session): session closed for user root Aug 18 17:34:58 home-player volumio[1181]: info: Successfully Stopped Audio Input Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand add "https://eu10.fastcast4u.com:8120" Aug 18 17:34:59 home-player volumio[1181]: error: updateQueue error: null Aug 18 17:34:59 home-player volumio[1181]: error: updateQueue error: null Aug 18 17:34:59 home-player volumio[1181]: error: updateQueue error: null Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 832ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 831ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand add "https://eu10.fastcast4u.com:8120" took 1 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand play Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 1ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand play took 0 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 1ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 1ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 1ms Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 15 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 15 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 14 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 15 milliseconds Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":null,"album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus stop Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":null,"album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":null,"album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":null,"album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 32ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 66ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 66ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 66ms Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 53 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 3 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 2 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 2 milliseconds Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 13ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 13 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 11ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 11 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 11ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 11 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 10ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 10 milliseconds Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 113ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 62ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 62ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 61ms Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 46 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 45 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 45 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 44 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 100ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 97ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 96ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 96ms Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces system playlist update Aug 18 17:34:59 home-player volumio[1181]: info: Ignoring MPD Status Update Aug 18 17:34:59 home-player volumio[1181]: info: Aug 18 17:34:59 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 71ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 71 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 3ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 2 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 2ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 2 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 2ms Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand status took 2 milliseconds Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 18 17:34:59 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1360,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jaki Graham - Round and Around","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jaki Graham - Round and Around","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jaki Graham - Round and Around","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:34:59 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:34:59 home-player volumio[1181]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1485,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Jaki Graham - Round and Around","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 17:34:59 home-player volumio[1181]: verbose: CURRENT POSITION 2 Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState stateService play Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::syncState currentStatus play Aug 18 17:34:59 home-player volumio[1181]: info: Received an update from plugin. extracting info from payload Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:34:59 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:34:59 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 111ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 44ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 43ms Aug 18 17:34:59 home-player volumio[1181]: info: ------------------------------ 44ms Aug 18 17:35:16 home-player volumio[1181]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 17:35:16 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 18 17:35:16 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:16 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 17:35:17 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:17 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:17 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:17 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:17 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:17 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:17 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:17 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 18 17:35:17 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 18 17:35:29 home-player volumio[1181]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 18 17:35:29 home-player volumio[1181]: info: Preparing to save Alsa Options, stopping services first Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::volumioGetState Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::volumioStop Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::stop Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::stPlaybackTimer Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::updateTrackBlock Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrackBlock Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::serviceStop Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::serviceStop Aug 18 17:35:29 home-player volumio[1181]: info: [1723995329520] ControllerWebradio::stop Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand stop Aug 18 17:35:29 home-player volumio[1181]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"Saffire 6 USB"},"i2s":true,"i2sid":{"value":"hifiberry-dacplusadcpro","label":"HiFiBerry DAC Plus ADC PRO"}} Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: Enabling I2S DAC: HiFiBerry DAC Plus ADC PRO Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:29 home-player sudo[3414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Aug 18 17:35:29 home-player sudo[3414]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:29 home-player sudo[3414]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:29 home-player volumio[1181]: info: No Overlays Loaded Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:29 home-player sudo[3417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dacplusadcpro Aug 18 17:35:29 home-player sudo[3417]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:29 home-player sudo[3417]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: Found match in i2s Card Database: setting mixer Digital for card HiFiBerry DAC Plus ADC PRO Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 18 17:35:29 home-player volumio[1181]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC Plus ADC PRO Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 18 17:35:29 home-player volumio[1181]: info: Disabling external Volume Control Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Aug 18 17:35:29 home-player volumio[1181]: info: Preparing to generate the ALSA configuration file Aug 18 17:35:29 home-player volumio[1181]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 18 17:35:29 home-player volumio[1181]: info: Reading ALSA contributions from plugins. Aug 18 17:35:29 home-player volumio[1181]: info: Aug 18 17:35:29 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:35:29 home-player volumio[1181]: info: sendMpdCommand stop took 151 milliseconds Aug 18 17:35:29 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:35:29 home-player volumio[1181]: info: Aug 18 17:35:29 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:35:29 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:35:29 home-player volumio[1181]: info: Aug 18 17:35:29 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:35:29 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:35:29 home-player volumio[1181]: info: Aug 18 17:35:29 home-player volumio[1181]: ---------------------------- MPD announces state update: player Aug 18 17:35:29 home-player volumio[1181]: info: ControllerMpd::getState Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand status Aug 18 17:35:29 home-player volumio[1181]: error: Cannot enable I2S Param: Error: Command failed: /usr/bin/sudo /usr/bin/dtoverlay hifiberry-dacplusadcpro Aug 18 17:35:29 home-player volumio[1181]: * Failed to apply overlay '0_hifiberry-dacplusadcpro' (kernel) Aug 18 17:35:29 home-player volumio[1181]: info: sendMpdCommand status took 11 milliseconds Aug 18 17:35:29 home-player volumio[1181]: info: sendMpdCommand status took 13 milliseconds Aug 18 17:35:29 home-player volumio[1181]: info: sendMpdCommand status took 13 milliseconds Aug 18 17:35:29 home-player volumio[1181]: info: sendMpdCommand status took 12 milliseconds Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::parseState Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 17:35:29 home-player volumio[1181]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 18 17:35:29 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 11 milliseconds Aug 18 17:35:29 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 18 17:35:29 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 18 17:35:29 home-player volumio[1181]: info: sendMpdCommand playlistinfo took 10 milliseconds Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:35:29 home-player volumio[1181]: verbose: ControllerMpd::parseTrackInfo Aug 18 17:35:29 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 17:35:29 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 17:35:29 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 17:35:29 home-player volumio[1181]: info: ControllerMpd::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::servicePushState Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 17:35:29 home-player volumio[1181]: info: ------------------------------ 62ms Aug 18 17:35:29 home-player volumio[1181]: info: ------------------------------ 61ms Aug 18 17:35:29 home-player volumio[1181]: info: ------------------------------ 60ms Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 17:35:29 home-player volumio[1181]: info: Getting Alsa Cards List without I2S DAC Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 18 17:35:29 home-player volumio[1181]: info: VolumeController:: Volume=100 Mute =false Aug 18 17:35:29 home-player volumio[1181]: info: CoreStateMachine::pushState Aug 18 17:35:29 home-player volumio[1181]: info: CorePlayQueue::getTrack 2 Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::volumioPushState Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output update for this device Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Pushing multiroomSync output Aug 18 17:35:29 home-player volumio[1181]: info: Asound.conf file written Aug 18 17:35:29 home-player sudo[3444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 18 17:35:29 home-player sudo[3444]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:29 home-player sudo[3444]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:29 home-player volumio[1181]: ALSA lib conf.c:1887:(_snd_config_load_with_include) _toplevel_:397:30:Unexpected char Aug 18 17:35:29 home-player volumio[1181]: /usr/sbin/alsactl: load_state:1674: snd_config_load error: Invalid argument Aug 18 17:35:29 home-player volumio[1181]: info: Output device has changed, restarting MPD Aug 18 17:35:29 home-player sudo[3449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 17:35:29 home-player volumio[1181]: info: Output device has changed, restarting Shairport Sync Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:29 home-player sudo[3449]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:29 home-player sudo[3449]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:29 home-player sudo[3451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 17:35:29 home-player sudo[3451]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:29 home-player systemd[1]: Stopping Music Player Daemon... Aug 18 17:35:29 home-player volumio[1181]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 17:35:29 home-player volumio[1181]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 18 17:35:29 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:29 home-player systemd[1]: mpd.service: Succeeded. Aug 18 17:35:29 home-player systemd[1]: Stopped Music Player Daemon. Aug 18 17:35:29 home-player vtcs[2786]: [2024-08-18 17:35:29.969] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Aug 18 17:35:29 home-player vtcs[2786]: [2024-08-18 17:35:29.970] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer Aug 18 17:35:29 home-player vtcs[2786]: [2024-08-18 17:35:29.970] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Aug 18 17:35:29 home-player systemd[1]: Starting Music Player Daemon... Aug 18 17:35:29 home-player volumio[1181]: info: Output device has changed, restarting MPD Aug 18 17:35:29 home-player sudo[3461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 17:35:29 home-player sudo[3461]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player systemd[1]: Stopping Volumio Tidal Connect Service... Aug 18 17:35:30 home-player systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Aug 18 17:35:30 home-player systemd[1]: vtcs.service: Succeeded. Aug 18 17:35:30 home-player systemd[1]: Stopped Volumio Tidal Connect Service. Aug 18 17:35:30 home-player sudo[3457]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 17:35:30 home-player sudo[3457]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 17:35:30 home-player sudo[3457]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 17:35:30 home-player sudo[3465]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player sudo[3465]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3461]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: info: Output device has changed, restarting Shairport Sync Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:30 home-player sudo[3471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 17:35:30 home-player sudo[3471]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player volumio[1181]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 17:35:30 home-player volumio[1181]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 18 17:35:30 home-player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player systemd[1]: mpd.service: Succeeded. Aug 18 17:35:30 home-player systemd[1]: Stopped Music Player Daemon. Aug 18 17:35:30 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 17:35:30 home-player sudo[3479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 17:35:30 home-player sudo[3479]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player systemd[1]: Starting Music Player Daemon... Aug 18 17:35:30 home-player sudo[3483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 17:35:30 home-player sudo[3483]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player sudo[3479]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player sudo[3486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 17:35:30 home-player sudo[3486]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: info: MPD Permissions set Aug 18 17:35:30 home-player volumio[1181]: info: MPD Permissions set Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player sudo[3483]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3475]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 17:35:30 home-player sudo[3475]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:30 home-player sudo[3486]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player sudo[3475]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: Starting Shairport Sync Aug 18 17:35:30 home-player volumio[1181]: info: Starting Shairport Sync Aug 18 17:35:30 home-player sudo[3502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 17:35:30 home-player sudo[3502]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player volumio[1181]: info: Preparing to generate the ALSA configuration file Aug 18 17:35:30 home-player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 18 17:35:30 home-player sudo[3505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 17:35:30 home-player sudo[3505]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player volumio[1181]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 18 17:35:30 home-player volumio[1181]: info: Reading ALSA contributions from plugins. Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: info: Asound.conf file written Aug 18 17:35:30 home-player systemd[1]: shairport-sync.service: Succeeded. Aug 18 17:35:30 home-player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 18 17:35:30 home-player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 17:35:30 home-player sudo[3505]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3502]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 18 17:35:30 home-player sudo[3509]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player sudo[3509]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: ALSA lib conf.c:1887:(_snd_config_load_with_include) _toplevel_:397:30:Unexpected char Aug 18 17:35:30 home-player volumio[1181]: /usr/sbin/alsactl: load_state:1674: snd_config_load error: Invalid argument Aug 18 17:35:30 home-player volumio[1181]: info: Output device has changed, restarting MPD Aug 18 17:35:30 home-player sudo[3516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 17:35:30 home-player sudo[3516]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player volumio[1181]: info: Output device has changed, restarting Shairport Sync Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player sudo[3516]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:30 home-player sudo[3519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 17:35:30 home-player sudo[3519]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 18 17:35:30 home-player systemd[1]: mpd.service: Succeeded. Aug 18 17:35:30 home-player systemd[1]: Stopped Music Player Daemon. Aug 18 17:35:30 home-player volumio[1181]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 17:35:30 home-player volumio[1181]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: Preparing to generate the ALSA configuration file Aug 18 17:35:30 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 17:35:30 home-player sudo[3528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 17:35:30 home-player sudo[3528]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player systemd[1]: Starting Music Player Daemon... Aug 18 17:35:30 home-player volumio[1181]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 18 17:35:30 home-player volumio[1181]: info: Reading ALSA contributions from plugins. Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: info: MPD Permissions set Aug 18 17:35:30 home-player volumio[1181]: info: Shairport-Sync Started Aug 18 17:35:30 home-player volumio[1181]: info: Shairport-Sync Started Aug 18 17:35:30 home-player sudo[3532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 17:35:30 home-player sudo[3528]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3532]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player sudo[3524]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 17:35:30 home-player sudo[3524]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player sudo[3532]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:30 home-player sudo[3524]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: error: Upnp client error: Error: This socket has been ended by the other party Aug 18 17:35:30 home-player volumio[1181]: info: Starting Shairport Sync Aug 18 17:35:30 home-player volumio[1181]: info: Asound.conf file unchanged, so no further update is needed Aug 18 17:35:30 home-player volumio[1181]: info: Output device has changed, restarting MPD Aug 18 17:35:30 home-player sudo[3543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 17:35:30 home-player sudo[3543]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player sudo[3546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 17:35:30 home-player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 18 17:35:30 home-player sudo[3546]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player systemd[1]: shairport-sync.service: Succeeded. Aug 18 17:35:30 home-player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 18 17:35:30 home-player sudo[3546]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 17:35:30 home-player volumio[1181]: info: Output device has changed, restarting Shairport Sync Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:30 home-player sudo[3551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 17:35:30 home-player sudo[3543]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3551]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 18 17:35:30 home-player systemd[1]: mpd.service: Succeeded. Aug 18 17:35:30 home-player volumio[1181]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 17:35:30 home-player systemd[1]: Stopped Music Player Daemon. Aug 18 17:35:30 home-player volumio[1181]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player systemd[1]: Starting Music Player Daemon... Aug 18 17:35:30 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 17:35:30 home-player sudo[3561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 17:35:30 home-player sudo[3561]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player sudo[3557]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 17:35:30 home-player sudo[3557]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player sudo[3557]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player volumio[1181]: info: MPD Permissions set Aug 18 17:35:30 home-player volumio[1181]: info: Shairport-Sync Started Aug 18 17:35:30 home-player sudo[3565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 17:35:30 home-player sudo[3565]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player volumio[1181]: (node:1181) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 17:35:30 home-player volumio[1181]: (Use `node --trace-warnings ...` to show where the warning was created) Aug 18 17:35:30 home-player volumio[1181]: (node:1181) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 17:35:30 home-player volumio[1181]: (node:1181) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 17:35:30 home-player volumio[1181]: (node:1181) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 17:35:30 home-player volumio[1181]: (node:1181) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 17:35:30 home-player volumio[1181]: info: Starting Shairport Sync Aug 18 17:35:30 home-player sudo[3561]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 17:35:30 home-player sudo[3565]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3573]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 17:35:30 home-player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 17:35:30 home-player systemd[1]: shairport-sync.service: Succeeded. Aug 18 17:35:30 home-player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 18 17:35:30 home-player volumio[1181]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 17:35:30 home-player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 17:35:30 home-player sudo[3573]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: info: Shairport-Sync Started Aug 18 17:35:30 home-player mpd[3566]: Aug 18 17:35 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 18 17:35:30 home-player systemd[1]: Started Music Player Daemon. Aug 18 17:35:30 home-player sudo[3551]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3451]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3471]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player sudo[3519]: pam_unix(sudo:session): session closed for user root Aug 18 17:35:30 home-player volumio[1181]: error: MPD error: The expression evaluated to a falsy value: Aug 18 17:35:30 home-player volumio[1181]: assert.ok(self.idling) Aug 18 17:35:30 home-player volumio[1181]: error: The expression evaluated to a falsy value: Aug 18 17:35:30 home-player volumio[1181]: assert.ok(self.idling) Aug 18 17:35:30 home-player volumio[1181]: error: MPD error: The expression evaluated to a falsy value: Aug 18 17:35:30 home-player volumio[1181]: assert.ok(self.idling) Aug 18 17:35:30 home-player volumio[1181]: error: The expression evaluated to a falsy value: Aug 18 17:35:30 home-player volumio[1181]: assert.ok(self.idling) Aug 18 17:35:30 home-player volumio[1181]: error: MPD error: The expression evaluated to a falsy value: Aug 18 17:35:30 home-player volumio[1181]: assert.ok(self.idling) Aug 18 17:35:30 home-player volumio[1181]: error: The expression evaluated to a falsy value: Aug 18 17:35:30 home-player volumio[1181]: assert.ok(self.idling) Aug 18 17:35:30 home-player volumio[1181]: error: updateQueue error: null Aug 18 17:35:31 home-player volumio[1181]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Aug 18 17:35:31 home-player volumio[1181]: info: PLUGIN onReboot : networkfs Aug 18 17:35:31 home-player volumio[1181]: info: PLUGIN onReboot : audiophonicsonoff Aug 18 17:35:31 home-player volumio[1181]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 17:35:31 home-player volumio[1181]: TypeError: Cannot read property 'writeSync' of undefined Aug 18 17:35:31 home-player volumio[1181]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Aug 18 17:35:31 home-player volumio[1181]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Aug 18 17:35:31 home-player volumio[1181]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Aug 18 17:35:31 home-player volumio[1181]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Aug 18 17:35:31 home-player volumio[1181]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Aug 18 17:35:31 home-player volumio[1181]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Aug 18 17:35:31 home-player volumio[1181]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22) Aug 18 17:35:31 home-player volumio[1181]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Aug 18 17:35:31 home-player volumio[1181]: at Socket.emit (events.js:315:20) Aug 18 17:35:31 home-player volumio[1181]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 18 17:35:31 home-player volumio[1181]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 18 17:35:31 home-player volumio[1181]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 17:35:31 home-player sudo[3591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-18 17:34 Aug 18 17:35:31 home-player sudo[3591]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"