-- Logs begin at Sun 2024-08-18 20:08:10 CEST, end at Sun 2024-08-18 21:02:26 CEST. -- Aug 18 21:01:00 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 18 21:01:01 home-player volumio[1160]: info: Preload queue cleared Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , handleBrowseUri Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::volumioStop Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::stop Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::stPlaybackTimer Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::updateTrackBlock Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrackBlock Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::serviceStop Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::serviceStop Aug 18 21:01:05 home-player volumio[1160]: info: [1724007665338] ControllerWebradio::stop Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Aug 18 21:01:05 home-player volumio[1160]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Aug 18 21:01:05 home-player volumio[1160]: info: Aug 18 21:01:05 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:05 home-player volumio[1160]: info: sendMpdCommand stop took 22 milliseconds Aug 18 21:01:05 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:05 home-player volumio[1160]: info: Aug 18 21:01:05 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:05 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:05 home-player volumio[1160]: info: Aug 18 21:01:05 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:05 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:05 home-player volumio[1160]: info: Aug 18 21:01:05 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:05 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:05 home-player volumio[1160]: info: sendMpdCommand status took 1 milliseconds Aug 18 21:01:05 home-player volumio[1160]: info: sendMpdCommand status took 1 milliseconds Aug 18 21:01:05 home-player volumio[1160]: info: sendMpdCommand status took 1 milliseconds Aug 18 21:01:05 home-player volumio[1160]: info: sendMpdCommand status took 1 milliseconds Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:05 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 21:01:05 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 21:01:05 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:05 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:05 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 21:01:05 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 21:01:05 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 21:01:05 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:05 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:05 home-player volumio[1160]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 21:01:05 home-player volumio[1160]: info: ------------------------------ 18ms Aug 18 21:01:05 home-player volumio[1160]: info: ------------------------------ 17ms Aug 18 21:01:05 home-player volumio[1160]: info: ------------------------------ 17ms Aug 18 21:01:05 home-player volumio[1160]: info: ------------------------------ 16ms Aug 18 21:01:05 home-player volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 18 21:01:05 home-player volumio[1160]: info: Enabling Audio Input 2 Aug 18 21:01:05 home-player sudo[5334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart audioinput.service Aug 18 21:01:05 home-player sudo[5334]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:01:05 home-player systemd[1]: Started Audio Input Service. Aug 18 21:01:05 home-player sudo[5334]: pam_unix(sudo:session): session closed for user root Aug 18 21:01:05 home-player volumio[1160]: info: Successfully Started Audio Input Aug 18 21:01:05 home-player volumio[1160]: info: Notifying AUDIO INPUT Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:05 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::volumiosetSourceActiveaudio_input/2 Aug 18 21:01:05 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 21:01:05 home-player volumio[1160]: Cannot find translation for source YouTube2 Aug 18 21:01:05 home-player volumio[1160]: Cannot find translation for source HiFiBerry ADC Aug 18 21:01:05 home-player volumio[1160]: Cannot find translation for source Saffire 6 USB Aug 18 21:01:05 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 21:01:06 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:06 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:06 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:06 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:06 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:06 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:06 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:06 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:06 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:06 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:06 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , handleBrowseUri Aug 18 21:01:07 home-player volumio[1160]: info: Unsetting Volatile before setting PC Input Aug 18 21:01:07 home-player volumio[1160]: verbose: UNSET VOLATILE: Service: smart_inputs Aug 18 21:01:07 home-player volumio[1160]: info: Disabiling Audio Input 2 Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::volumioStop Aug 18 21:01:07 home-player volumio[1160]: info: CoreStateMachine::stop Aug 18 21:01:07 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 21:01:07 home-player volumio[1160]: info: CoreStateMachine::stPlaybackTimer Aug 18 21:01:07 home-player volumio[1160]: info: CoreStateMachine::updateTrackBlock Aug 18 21:01:07 home-player volumio[1160]: info: CorePlayQueue::getTrackBlock Aug 18 21:01:07 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:07 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:07 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:07 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:07 home-player volumio[1160]: info: CoreStateMachine::serviceStop Aug 18 21:01:07 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::serviceStop Aug 18 21:01:07 home-player volumio[1160]: info: [1724007667600] ControllerWebradio::stop Aug 18 21:01:07 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Aug 18 21:01:07 home-player volumio[1160]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Aug 18 21:01:07 home-player sudo[5340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop audioinput.service Aug 18 21:01:07 home-player sudo[5340]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:01:07 home-player volumio[1160]: info: sendMpdCommand stop took 8 milliseconds Aug 18 21:01:07 home-player systemd[1]: Stopping Audio Input Service... Aug 18 21:01:07 home-player systemd[1]: audioinput.service: Main process exited, code=killed, status=15/TERM Aug 18 21:01:07 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:01:07 home-player volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 18 21:01:07 home-player systemd[1]: audioinput.service: Succeeded. Aug 18 21:01:07 home-player systemd[1]: Stopped Audio Input Service. Aug 18 21:01:07 home-player sudo[5340]: pam_unix(sudo:session): session closed for user root Aug 18 21:01:07 home-player volumio[1160]: info: Successfully Stopped Audio Input Aug 18 21:01:07 home-player volumio[1160]: info: Enabling Audio Input 5 Aug 18 21:01:07 home-player sudo[5347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart audioinput.service Aug 18 21:01:07 home-player sudo[5347]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:01:07 home-player systemd[1]: Started Audio Input Service. Aug 18 21:01:07 home-player sudo[5347]: pam_unix(sudo:session): session closed for user root Aug 18 21:01:07 home-player volumio[1160]: info: Successfully Started Audio Input Aug 18 21:01:07 home-player volumio[1160]: info: Notifying AUDIO INPUT Aug 18 21:01:07 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:07 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:07 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:07 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::volumiosetSourceActiveaudio_input/5 Aug 18 21:01:07 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 21:01:07 home-player volumio[1160]: Cannot find translation for source YouTube2 Aug 18 21:01:07 home-player volumio[1160]: Cannot find translation for source HiFiBerry ADC Aug 18 21:01:07 home-player volumio[1160]: Cannot find translation for source Saffire 6 USB Aug 18 21:01:08 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:08 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:08 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:08 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:08 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:08 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:08 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:08 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:08 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:08 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:08 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:15 home-player volumiologrotate[921]: ls: cannot access '/var/log/samba/log.wb-HOME': No such file or directory Aug 18 21:01:15 home-player volumiologrotate[921]: ls: cannot access 'PLAYER': No such file or directory Aug 18 21:01:18 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 18 21:01:18 home-player volumio[1160]: info: CURURI: playlists Aug 18 21:01:18 home-player volumio[1160]: info: Listing playlists Aug 18 21:01:18 home-player volumio[1160]: info: Preload queue cleared Aug 18 21:01:19 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 18 21:01:19 home-player volumio[1160]: info: CURURI: playlists/Disco lista Aug 18 21:01:19 home-player volumio[1160]: info: Preload queue cleared Aug 18 21:01:22 home-player volumio[1160]: info: Preload queue cleared Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::ClearQueue Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::stop Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::serviceStop Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::serviceStop Aug 18 21:01:22 home-player volumio[1160]: info: INPUTS, stopping input: audio_input Aug 18 21:01:22 home-player volumio[1160]: info: Disabiling Audio Input 5 Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::clearPlayQueue Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::saveQueue Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::volumioPushQueue Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::addQueueItems Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::addQueueItems Aug 18 21:01:22 home-player volumio[1160]: info: Preload queue cleared Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: https://0n-disco.radionetz.de/0n-disco.mp3 Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: https://maiban00.radioca.st/stream Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: https://eu10.fastcast4u.com:8120 Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1751095 Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: https://broadcast.miami/proxy/thediscoparadise?mp=/stream/ Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: https://stream.rcs.revma.com/2gx7q01a0mzuv Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: https://scdn.nrjaudio.fm/adwz1/fr/30617/mp3_128.mp3?origine=tuneinradio Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: https://scdn.nrjaudio.fm/adwz1/fr/30773/mp3_128.mp3?origine=tuneinradio Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: https://scdn.nrjaudio.fm/adwz1/fr/55524/mp3_128.mp3?origine=tuneinradio Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: Adding Item to queue: https://scdn.nrjaudio.fm/adwz1/fr/58333/mp3_128.mp3?origine=tuneinradio Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::volumioPushQueue Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::saveQueue Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::updateTrackBlock Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::getTrackBlock Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::volumioPlay Aug 18 21:01:22 home-player volumio[1160]: verbose: UNSET VOLATILE: Service: smart_inputs Aug 18 21:01:22 home-player volumio[1160]: info: Disabiling Audio Input 5 Aug 18 21:01:22 home-player sudo[5400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop audioinput.service Aug 18 21:01:22 home-player sudo[5400]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::play index 2 Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::stop Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::stPlaybackTimer Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::updateTrackBlock Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::getTrackBlock Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:22 home-player systemd[1]: Stopping Audio Input Service... Aug 18 21:01:22 home-player systemd[1]: audioinput.service: Main process exited, code=killed, status=15/TERM Aug 18 21:01:22 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:22 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::serviceStop Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:22 home-player volumio[1160]: info: CoreCommandRouter::serviceStop Aug 18 21:01:22 home-player volumio[1160]: info: [1724007682327] ControllerWebradio::stop Aug 18 21:01:22 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Aug 18 21:01:22 home-player sudo[5403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop audioinput.service Aug 18 21:01:22 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:01:22 home-player volumio[1160]: info: sendMpdCommand stop took 8 milliseconds Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::play index undefined Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:22 home-player volumio[1160]: info: CoreStateMachine::startPlaybackTimer Aug 18 21:01:22 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:22 home-player volumio[1160]: info: [1724007682336] ControllerWebradio::clearAddPlayTrack Aug 18 21:01:22 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Aug 18 21:01:22 home-player sudo[5403]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:01:22 home-player volumio[1160]: info: sendMpdCommand stop took 0 milliseconds Aug 18 21:01:22 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand clear Aug 18 21:01:22 home-player volumio[1160]: info: Aug 18 21:01:22 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:22 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:22 home-player volumio[1160]: info: sendMpdCommand clear took 12 milliseconds Aug 18 21:01:22 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand load "https://eu10.fastcast4u.com:8120" Aug 18 21:01:22 home-player volumio[1160]: info: Aug 18 21:01:22 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:22 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:22 home-player volumio[1160]: info: Aug 18 21:01:22 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:22 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:22 home-player volumio[1160]: info: Aug 18 21:01:22 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:22 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:22 home-player volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 18 21:01:22 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:01:22 home-player systemd[1]: audioinput.service: Succeeded. Aug 18 21:01:22 home-player systemd[1]: Stopped Audio Input Service. Aug 18 21:01:22 home-player sudo[5403]: pam_unix(sudo:session): session closed for user root Aug 18 21:01:22 home-player sudo[5400]: pam_unix(sudo:session): session closed for user root Aug 18 21:01:22 home-player volumio[1160]: info: Successfully Stopped Audio Input Aug 18 21:01:22 home-player volumio[1160]: info: Successfully Stopped Audio Input Aug 18 21:01:23 home-player volumio[1160]: error: updateQueue error: null Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 1054ms Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand add "https://eu10.fastcast4u.com:8120" Aug 18 21:01:23 home-player volumio[1160]: error: updateQueue error: null Aug 18 21:01:23 home-player volumio[1160]: error: updateQueue error: null Aug 18 21:01:23 home-player volumio[1160]: error: updateQueue error: null Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 1054ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 1054ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 1053ms Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand add "https://eu10.fastcast4u.com:8120" took 1 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand play Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 1ms Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand play took 2 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 2ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 1ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 1ms Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 16 milliseconds Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 17 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 16 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 16 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus stop Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 18ms Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 3 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 2 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 1 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 1 milliseconds Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 45ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 45ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 45ms Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 27 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 28 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 27 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 27 milliseconds Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 65ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 64ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 63ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 63ms Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 54ms Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 53 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 2ms Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 2 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 2ms Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 3 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 2ms Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 2 milliseconds Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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":"eu10.fastcast4u.com:8120","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 77ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 26ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 26ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 25ms Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces system playlist update Aug 18 21:01:23 home-player volumio[1160]: info: Ignoring MPD Status Update Aug 18 21:01:23 home-player volumio[1160]: info: Aug 18 21:01:23 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 3ms Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 3 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 4ms Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 4 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 2ms Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 2 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 1ms Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand status took 1 milliseconds Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 21:01:23 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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":"Earth Wind and Fire - Serpentine","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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":"Earth Wind and Fire - Serpentine","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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":"Earth Wind and Fire - Serpentine","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:01:23 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:01:23 home-player volumio[1160]: 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":"Earth Wind and Fire - Serpentine","artist":"B4B DISCO FUNK [HD]","album":null,"uri":"https://eu10.fastcast4u.com:8120","trackType":"com:8120"} Aug 18 21:01:23 home-player volumio[1160]: verbose: CURRENT POSITION 2 Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState stateService play Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::syncState currentStatus play Aug 18 21:01:23 home-player volumio[1160]: info: Received an update from plugin. extracting info from payload Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:01:23 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:01:23 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 28ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 28ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 26ms Aug 18 21:01:23 home-player volumio[1160]: info: ------------------------------ 25ms Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , handleBrowseUri Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::volumioStop Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::stop Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::stPlaybackTimer Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::updateTrackBlock Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrackBlock Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::serviceStop Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::serviceStop Aug 18 21:02:11 home-player volumio[1160]: info: [1724007731370] ControllerWebradio::stop Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand stop Aug 18 21:02:11 home-player volumio[1160]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Aug 18 21:02:11 home-player volumio[1160]: info: Aug 18 21:02:11 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:02:11 home-player volumio[1160]: info: sendMpdCommand stop took 24 milliseconds Aug 18 21:02:11 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:02:11 home-player volumio[1160]: info: Aug 18 21:02:11 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:02:11 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:02:11 home-player volumio[1160]: info: Aug 18 21:02:11 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:02:11 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:02:11 home-player volumio[1160]: info: Aug 18 21:02:11 home-player volumio[1160]: ---------------------------- MPD announces state update: player Aug 18 21:02:11 home-player volumio[1160]: info: ControllerMpd::getState Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand status Aug 18 21:02:11 home-player volumio[1160]: info: sendMpdCommand status took 2 milliseconds Aug 18 21:02:11 home-player volumio[1160]: info: sendMpdCommand status took 3 milliseconds Aug 18 21:02:11 home-player volumio[1160]: info: sendMpdCommand status took 2 milliseconds Aug 18 21:02:11 home-player volumio[1160]: info: sendMpdCommand status took 1 milliseconds Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::parseState Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 18 21:02:11 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 18 21:02:11 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 18 21:02:11 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 18 21:02:11 home-player volumio[1160]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:02:11 home-player volumio[1160]: verbose: ControllerMpd::parseTrackInfo Aug 18 21:02:11 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 21:02:11 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 21:02:11 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 21:02:11 home-player volumio[1160]: info: ControllerMpd::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:02:11 home-player volumio[1160]: info: CorePlayQueue::getTrack 2 Aug 18 21:02:11 home-player volumio[1160]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 18 21:02:11 home-player volumio[1160]: info: ------------------------------ 15ms Aug 18 21:02:11 home-player volumio[1160]: info: ------------------------------ 15ms Aug 18 21:02:11 home-player volumio[1160]: info: ------------------------------ 14ms Aug 18 21:02:11 home-player volumio[1160]: info: ------------------------------ 14ms Aug 18 21:02:11 home-player volumio[1160]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 18 21:02:11 home-player volumio[1160]: info: Enabling Audio Input 2 Aug 18 21:02:11 home-player sudo[5417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart audioinput.service Aug 18 21:02:11 home-player sudo[5417]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:11 home-player systemd[1]: Started Audio Input Service. Aug 18 21:02:11 home-player sudo[5417]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:11 home-player volumio[1160]: info: Successfully Started Audio Input Aug 18 21:02:11 home-player volumio[1160]: info: Notifying AUDIO INPUT Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:02:11 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::volumiosetSourceActiveaudio_input/2 Aug 18 21:02:11 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 21:02:11 home-player volumio[1160]: Cannot find translation for source YouTube2 Aug 18 21:02:11 home-player volumio[1160]: Cannot find translation for source HiFiBerry ADC Aug 18 21:02:11 home-player volumio[1160]: Cannot find translation for source Saffire 6 USB Aug 18 21:02:11 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 21:02:12 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:02:12 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:02:12 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:02:12 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:02:12 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:02:12 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:02:12 home-player volumio[1160]: info: CoreCommandRouter::servicePushState Aug 18 21:02:12 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:02:12 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:02:12 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:02:12 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:02:15 home-player volumiologrotate[921]: ls: cannot access '/var/log/samba/log.wb-HOME': No such file or directory Aug 18 21:02:15 home-player volumiologrotate[921]: ls: cannot access 'PLAYER': No such file or directory Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 18 21:02:15 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 18 21:02:24 home-player volumio[1160]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 18 21:02:24 home-player volumio[1160]: info: Preparing to save Alsa Options, stopping services first Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::volumioGetState Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::volumioPause Aug 18 21:02:24 home-player volumio[1160]: info: CoreStateMachine::pause Aug 18 21:02:24 home-player volumio[1160]: info: CoreStateMachine::stPlaybackTimer Aug 18 21:02:24 home-player volumio[1160]: info: CoreStateMachine::servicePause Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::servicePause Aug 18 21:02:24 home-player volumio[1160]: info: [1724007744868] Inputs::pause Aug 18 21:02:24 home-player volumio[1160]: 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 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:24 home-player volumio[1160]: info: Enabling I2S DAC: HiFiBerry DAC Plus ADC PRO Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:24 home-player sudo[5474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Aug 18 21:02:24 home-player sudo[5474]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:24 home-player sudo[5474]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:24 home-player volumio[1160]: info: No Overlays Loaded Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:24 home-player sudo[5477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay hifiberry-dacplusadcpro Aug 18 21:02:24 home-player sudo[5477]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:24 home-player sudo[5477]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:24 home-player volumio[1160]: info: Found match in i2s Card Database: setting mixer Digital for card HiFiBerry DAC Plus ADC PRO Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 18 21:02:24 home-player volumio[1160]: 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 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 18 21:02:24 home-player volumio[1160]: info: Disabling external Volume Control Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 18 21:02:24 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Aug 18 21:02:24 home-player volumio[1160]: info: Preparing to generate the ALSA configuration file Aug 18 21:02:25 home-player volumio[1160]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 18 21:02:25 home-player volumio[1160]: info: Reading ALSA contributions from plugins. Aug 18 21:02:25 home-player volumio[1160]: error: Cannot enable I2S Param: Error: Command failed: /usr/bin/sudo /usr/bin/dtoverlay hifiberry-dacplusadcpro Aug 18 21:02:25 home-player volumio[1160]: * Failed to apply overlay '0_hifiberry-dacplusadcpro' (kernel) Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 21:02:25 home-player volumio[1160]: info: Getting Alsa Cards List without I2S DAC Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 18 21:02:25 home-player volumio[1160]: info: VolumeController:: Volume=100 Mute =false Aug 18 21:02:25 home-player volumio[1160]: info: CoreStateMachine::pushState Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::volumioPushState Aug 18 21:02:25 home-player volumio[1160]: info: MRS: Pushing multiroomSync output update for this device Aug 18 21:02:25 home-player volumio[1160]: info: MRS: Pushing multiroomSync output Aug 18 21:02:25 home-player volumio[1160]: info: Asound.conf file written Aug 18 21:02:25 home-player sudo[5502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 18 21:02:25 home-player sudo[5502]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player sudo[5502]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player volumio[1160]: ALSA lib conf.c:1887:(_snd_config_load_with_include) _toplevel_:397:30:Unexpected char Aug 18 21:02:25 home-player volumio[1160]: /usr/sbin/alsactl: load_state:1674: snd_config_load error: Invalid argument Aug 18 21:02:25 home-player volumio[1160]: info: Output device has changed, restarting MPD Aug 18 21:02:25 home-player sudo[5507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 21:02:25 home-player sudo[5507]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: info: Output device has changed, restarting Shairport Sync Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player sudo[5507]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player sudo[5510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 21:02:25 home-player sudo[5510]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player systemd[1]: Stopping Music Player Daemon... Aug 18 21:02:25 home-player volumio[1160]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 21:02:25 home-player volumio[1160]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player systemd[1]: mpd.service: Succeeded. Aug 18 21:02:25 home-player systemd[1]: Stopped Music Player Daemon. Aug 18 21:02:25 home-player vtcs[5117]: [2024-08-18 21:02:25.262] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Aug 18 21:02:25 home-player vtcs[5117]: [2024-08-18 21:02:25.266] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=5 errorno=104 error=Connection reset by peer Aug 18 21:02:25 home-player vtcs[5117]: [2024-08-18 21:02:25.266] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Aug 18 21:02:25 home-player systemd[1]: Starting Music Player Daemon... Aug 18 21:02:25 home-player volumio[1160]: info: Output device has changed, restarting MPD Aug 18 21:02:25 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 21:02:25 home-player sudo[5520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 21:02:25 home-player sudo[5520]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player sudo[5516]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 21:02:25 home-player sudo[5516]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player sudo[5516]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player sudo[5521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 21:02:25 home-player sudo[5521]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player sudo[5521]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player systemd[1]: Stopping Volumio Tidal Connect Service... Aug 18 21:02:25 home-player systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Aug 18 21:02:25 home-player systemd[1]: vtcs.service: Succeeded. Aug 18 21:02:25 home-player systemd[1]: Stopped Volumio Tidal Connect Service. Aug 18 21:02:25 home-player volumio[1160]: info: Output device has changed, restarting Shairport Sync Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player sudo[5520]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player sudo[5529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 21:02:25 home-player sudo[5529]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 18 21:02:25 home-player systemd[1]: mpd.service: Succeeded. Aug 18 21:02:25 home-player systemd[1]: Stopped Music Player Daemon. Aug 18 21:02:25 home-player volumio[1160]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 21:02:25 home-player volumio[1160]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player systemd[1]: Starting Music Player Daemon... Aug 18 21:02:25 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 21:02:25 home-player sudo[5537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 21:02:25 home-player sudo[5537]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player sudo[5540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 21:02:25 home-player sudo[5540]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player sudo[5533]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 21:02:25 home-player sudo[5533]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player sudo[5533]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player sudo[5544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player sudo[5544]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player sudo[5537]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player volumio[1160]: info: MPD Permissions set Aug 18 21:02:25 home-player volumio[1160]: info: MPD Permissions set Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player sudo[5544]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player sudo[5540]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player volumio[1160]: info: Starting Shairport Sync Aug 18 21:02:25 home-player volumio[1160]: info: Starting Shairport Sync Aug 18 21:02:25 home-player sudo[5559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 21:02:25 home-player sudo[5559]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: info: Preparing to generate the ALSA configuration file Aug 18 21:02:25 home-player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 18 21:02:25 home-player systemd[1]: shairport-sync.service: Succeeded. Aug 18 21:02:25 home-player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 18 21:02:25 home-player volumio[1160]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 18 21:02:25 home-player volumio[1160]: info: Reading ALSA contributions from plugins. Aug 18 21:02:25 home-player sudo[5562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 21:02:25 home-player sudo[5562]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player volumio[1160]: info: Asound.conf file written Aug 18 21:02:25 home-player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 21:02:25 home-player sudo[5566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 18 21:02:25 home-player sudo[5566]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player sudo[5559]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 18 21:02:25 home-player systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 18 21:02:25 home-player systemd[1]: shairport-sync.service: Succeeded. Aug 18 21:02:25 home-player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 18 21:02:25 home-player sudo[5566]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 21:02:25 home-player sudo[5562]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player volumio[1160]: ALSA lib conf.c:1887:(_snd_config_load_with_include) _toplevel_:397:30:Unexpected char Aug 18 21:02:25 home-player volumio[1160]: /usr/sbin/alsactl: load_state:1674: snd_config_load error: Invalid argument Aug 18 21:02:25 home-player volumio[1160]: info: Output device has changed, restarting MPD Aug 18 21:02:25 home-player sudo[5576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 21:02:25 home-player sudo[5576]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player sudo[5576]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player volumio[1160]: info: Output device has changed, restarting Shairport Sync Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player sudo[5579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 21:02:25 home-player sudo[5579]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 18 21:02:25 home-player systemd[1]: mpd.service: Succeeded. Aug 18 21:02:25 home-player systemd[1]: Stopped Music Player Daemon. Aug 18 21:02:25 home-player volumio[1160]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 21:02:25 home-player volumio[1160]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player systemd[1]: Starting Music Player Daemon... Aug 18 21:02:25 home-player volumio[1160]: info: Preparing to generate the ALSA configuration file Aug 18 21:02:25 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 21:02:25 home-player sudo[5588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 21:02:25 home-player sudo[5588]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 18 21:02:25 home-player volumio[1160]: info: Reading ALSA contributions from plugins. Aug 18 21:02:25 home-player sudo[5584]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 21:02:25 home-player sudo[5584]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player sudo[5588]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player sudo[5584]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: info: MPD Permissions set Aug 18 21:02:25 home-player volumio[1160]: info: Shairport-Sync Started Aug 18 21:02:25 home-player volumio[1160]: (node:1160) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 21:02:25 home-player volumio[1160]: (Use `node --trace-warnings ...` to show where the warning was created) Aug 18 21:02:25 home-player volumio[1160]: (node:1160) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 21:02:25 home-player volumio[1160]: (node:1160) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 21:02:25 home-player volumio[1160]: (node:1160) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 21:02:25 home-player volumio[1160]: (node:1160) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Aug 18 21:02:25 home-player volumio[1160]: info: Shairport-Sync Started Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player sudo[5594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 21:02:25 home-player sudo[5594]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: Starting Shairport Sync Aug 18 21:02:25 home-player sudo[5594]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player volumio[1160]: info: Asound.conf file unchanged, so no further update is needed Aug 18 21:02:25 home-player volumio[1160]: info: Output device has changed, restarting MPD Aug 18 21:02:25 home-player sudo[5604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 21:02:25 home-player sudo[5604]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player sudo[5603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 21:02:25 home-player sudo[5604]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player sudo[5603]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: info: Output device has changed, restarting Shairport Sync Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 18 21:02:25 home-player systemd[1]: shairport-sync.service: Succeeded. Aug 18 21:02:25 home-player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 18 21:02:25 home-player sudo[5609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 21:02:25 home-player sudo[5609]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 21:02:25 home-player volumio[1160]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 18 21:02:25 home-player volumio[1160]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player sudo[5603]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 18 21:02:25 home-player systemd[1]: mpd.service: Succeeded. Aug 18 21:02:25 home-player systemd[1]: Stopped Music Player Daemon. Aug 18 21:02:25 home-player systemd[1]: Starting Music Player Daemon... Aug 18 21:02:25 home-player kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Aug 18 21:02:25 home-player sudo[5616]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 21:02:25 home-player sudo[5616]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player sudo[5616]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player sudo[5621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 21:02:25 home-player sudo[5621]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player volumio[1160]: info: MPD Permissions set Aug 18 21:02:25 home-player volumio[1160]: info: Shairport-Sync Started Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player sudo[5624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 21:02:25 home-player sudo[5624]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 21:02:25 home-player volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 21:02:25 home-player sudo[5624]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player sudo[5621]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:25 home-player volumio[1160]: info: Starting Shairport Sync Aug 18 21:02:25 home-player sudo[5635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 18 21:02:25 home-player sudo[5635]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 21:02:25 home-player systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: running Aug 18 21:02:25 home-player systemd[1]: shairport-sync.service: Succeeded. Aug 18 21:02:25 home-player systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 18 21:02:25 home-player volumio[1160]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Aug 18 21:02:26 home-player systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 18 21:02:26 home-player sudo[5635]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:26 home-player volumio[1160]: info: Shairport-Sync Started Aug 18 21:02:26 home-player mpd[5625]: Aug 18 21:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 18 21:02:26 home-player systemd[1]: Started Music Player Daemon. Aug 18 21:02:26 home-player sudo[5579]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:26 home-player sudo[5529]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:26 home-player sudo[5510]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:26 home-player sudo[5609]: pam_unix(sudo:session): session closed for user root Aug 18 21:02:26 home-player volumio[1160]: error: MPD error: The expression evaluated to a falsy value: Aug 18 21:02:26 home-player volumio[1160]: assert.ok(self.idling) Aug 18 21:02:26 home-player volumio[1160]: error: The expression evaluated to a falsy value: Aug 18 21:02:26 home-player volumio[1160]: assert.ok(self.idling) Aug 18 21:02:26 home-player volumio[1160]: error: MPD error: The expression evaluated to a falsy value: Aug 18 21:02:26 home-player volumio[1160]: assert.ok(self.idling) Aug 18 21:02:26 home-player volumio[1160]: error: The expression evaluated to a falsy value: Aug 18 21:02:26 home-player volumio[1160]: assert.ok(self.idling) Aug 18 21:02:26 home-player volumio[1160]: error: MPD error: The expression evaluated to a falsy value: Aug 18 21:02:26 home-player volumio[1160]: assert.ok(self.idling) Aug 18 21:02:26 home-player volumio[1160]: error: The expression evaluated to a falsy value: Aug 18 21:02:26 home-player volumio[1160]: assert.ok(self.idling) Aug 18 21:02:26 home-player volumio[1160]: error: updateQueue error: null Aug 18 21:02:26 home-player volumio[1160]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Aug 18 21:02:26 home-player volumio[1160]: info: PLUGIN onReboot : networkfs Aug 18 21:02:26 home-player volumio[1160]: info: PLUGIN onReboot : audiophonicsonoff Aug 18 21:02:26 home-player volumio[1160]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 21:02:26 home-player volumio[1160]: TypeError: Cannot read property 'writeSync' of undefined Aug 18 21:02:26 home-player volumio[1160]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Aug 18 21:02:26 home-player volumio[1160]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Aug 18 21:02:26 home-player volumio[1160]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Aug 18 21:02:26 home-player volumio[1160]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Aug 18 21:02:26 home-player volumio[1160]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Aug 18 21:02:26 home-player volumio[1160]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Aug 18 21:02:26 home-player volumio[1160]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22) Aug 18 21:02:26 home-player volumio[1160]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:864:33) Aug 18 21:02:26 home-player volumio[1160]: at Socket.emit (events.js:315:20) Aug 18 21:02:26 home-player volumio[1160]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 18 21:02:26 home-player volumio[1160]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 18 21:02:26 home-player volumio[1160]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 21:02:26 home-player sudo[5651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-18 21:01 Aug 18 21:02:26 home-player sudo[5651]: 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"