Dec 25 16:29:00 volumio volumio[22542]: info: Preload queue cleared Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::ClearQueue Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::stop Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::stPlaybackTimer Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::updateTrackBlock Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrackBlock Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::pushState Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 10 Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioPushState Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 10 Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::serviceStop Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 10 Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::serviceStop Dec 25 16:29:00 volumio volumio[22542]: info: ControllerMpd::stop Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand stop Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::clearPlayQueue Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::saveQueue Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioPushQueue Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::addQueueItems Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::addQueueItems Dec 25 16:29:00 volumio volumio[22542]: info: Preload queue cleared Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/01 Dronning Fjellrose.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/01 Dronning Fjellrose.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/02 Stille stille kommer vi.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/02 Stille stille kommer vi.dff Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioPushQueue Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::saveQueue Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::updateTrackBlock Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrackBlock Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 10 Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioPlay Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::play index 1 Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::addQueueItems Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::addQueueItems Dec 25 16:29:00 volumio volumio[22542]: info: Preload queue cleared Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/03 Dele alle ord og tanker.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/03 Dele alle ord og tanker.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/04 Redd Mamma.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/04 Redd Mamma.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/05 Sulla sulla krekling.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/05 Sulla sulla krekling.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/06 Blågutten.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/06 Blågutten.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/07 Ville fjellgutt.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/07 Ville fjellgutt.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/08 Hva skal hende nå.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/08 Hva skal hende nå.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/09 Ved bålet.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/09 Ved bålet.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/10 Tufsa danser.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/10 Tufsa danser.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/11 Vesle rare bygdeunge.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/11 Vesle rare bygdeunge.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/12 En blånissekveld.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/12 En blånissekveld.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/13 Kveldslokk for små unger.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/13 Kveldslokk for små unger.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/14 Lys i desember.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/14 Lys i desember.dff Dec 25 16:29:00 volumio volumio[22542]: info: Adding Item to queue: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/15 Ved bålet — instrumental bonus version.dff Dec 25 16:29:00 volumio volumio[22542]: info: Using cached record of: music-library/NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/15 Ved bålet — instrumental bonus version.dff Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::stop Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioPushQueue Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::saveQueue Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::play index undefined Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::updateTrackBlock Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrackBlock Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::startPlaybackTimer Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::clearAddPlayTracks NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/02 Stille stille kommer vi.dff Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand stop Dec 25 16:29:00 volumio volumio[22542]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 25 16:29:00 volumio volumio[22542]: info: sendMpdCommand stop took 43 milliseconds Dec 25 16:29:00 volumio volumio[22542]: info: sendMpdCommand stop took 17 milliseconds Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand clear Dec 25 16:29:00 volumio volumio[22542]: info: Dec 25 16:29:00 volumio volumio[22542]: ---------------------------- MPD announces system playlist update Dec 25 16:29:00 volumio volumio[22542]: info: Ignoring MPD Status Update Dec 25 16:29:00 volumio volumio[22542]: info: sendMpdCommand clear took 1 milliseconds Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand add "NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/02 Stille stille kommer vi.dff" Dec 25 16:29:00 volumio sudo[27983]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 25 16:29:00 volumio sudo[27983]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:00 volumio volumio[22542]: error: updateQueue error: null Dec 25 16:29:00 volumio volumio[22542]: info: Dec 25 16:29:00 volumio volumio[22542]: ---------------------------- MPD announces system playlist update Dec 25 16:29:00 volumio volumio[22542]: info: Ignoring MPD Status Update Dec 25 16:29:00 volumio volumio[22542]: info: ------------------------------ 11ms Dec 25 16:29:00 volumio volumio[22542]: info: sendMpdCommand add "NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/02 Stille stille kommer vi.dff" took 10 milliseconds Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand play Dec 25 16:29:00 volumio volumio[22542]: info: ------------------------------ 4ms Dec 25 16:29:00 volumio volumio[22542]: info: sendMpdCommand play took 5 milliseconds Dec 25 16:29:00 volumio volumio[22542]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 25 16:29:00 volumio volumio[22542]: info: Dec 25 16:29:00 volumio volumio[22542]: ---------------------------- MPD announces state update: player Dec 25 16:29:00 volumio volumio[22542]: info: ControllerMpd::getState Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand status Dec 25 16:29:00 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 25 16:29:00 volumio volumio[22542]: info: Dec 25 16:29:00 volumio volumio[22542]: ---------------------------- MPD announces state update: player Dec 25 16:29:00 volumio volumio[22542]: info: sendMpdCommand status took 36 milliseconds Dec 25 16:29:00 volumio volumio[22542]: info: ControllerMpd::getState Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand status Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::parseState Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 16:29:00 volumio volumio[22542]: info: sendMpdCommand status took 3 milliseconds Dec 25 16:29:00 volumio volumio[22542]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::parseState Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::parseTrackInfo Dec 25 16:29:00 volumio volumio[22542]: info: ControllerMpd::pushState Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::servicePushState Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:00 volumio volumio[22542]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"02 Stille stille kommer vi.dff","artist":null,"album":null,"uri":"NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/02 Stille stille kommer vi.dff","trackType":"dff"} Dec 25 16:29:00 volumio volumio[22542]: verbose: CURRENT POSITION 1 Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::syncState stateService play Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::syncState currentStatus stop Dec 25 16:29:00 volumio volumio[22542]: info: ------------------------------ 47ms Dec 25 16:29:00 volumio volumio[22542]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 25 16:29:00 volumio volumio[22542]: verbose: ControllerMpd::parseTrackInfo Dec 25 16:29:00 volumio volumio[22542]: info: ControllerMpd::pushState Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::servicePushState Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:00 volumio volumio[22542]: verbose: STATE SERVICE {"status":"play","position":0,"seek":366,"duration":240,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"02 Stille stille kommer vi.dff","artist":null,"album":null,"uri":"NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/02 Stille stille kommer vi.dff","trackType":"dff"} Dec 25 16:29:00 volumio volumio[22542]: verbose: CURRENT POSITION 1 Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::syncState stateService play Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::syncState currentStatus play Dec 25 16:29:00 volumio volumio[22542]: info: Received an update from plugin. extracting info from payload Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::pushState Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioPushState Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:00 volumio volumio[22542]: info: CoreStateMachine::pushState Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioPushState Dec 25 16:29:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:00 volumio volumio[22542]: info: ------------------------------ 66ms Dec 25 16:29:00 volumio volumio[22542]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 25 16:29:00 volumio volumio[22542]: info: PeppyMeterBasic ---peppymeterbasic status play Dec 25 16:29:00 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 25 16:29:00 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 25 16:29:00 volumio systemd[1]: peppymeterbasic.service: Consumed 19.373s CPU time. Dec 25 16:29:00 volumio sudo[27995]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 25 16:29:00 volumio sudo[27995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:00 volumio sudo[27993]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Dec 25 16:29:00 volumio sudo[27993]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:00 volumio sudo[27983]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:00 volumio volumio[22542]: info: peppymeterbasic Daemon Stop Dec 25 16:29:00 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 25 16:29:00 volumio sudo[27995]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:00 volumio volumio[22542]: info: peppymeterbasic Daemon Started Dec 25 16:29:00 volumio sudo[27993]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:00 volumio volumio[22542]: info: peppymeterbasic Daemon Started Dec 25 16:29:07 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:07 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:08 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 25 16:29:08 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 25 16:29:11 volumio volumio[22542]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 25 16:29:16 volumio volumiossh-tunnel[27610]: Connection to eu7.myvolumio.org closed by remote host. Dec 25 16:29:16 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:16 volumio autossh[27607]: starting ssh (count 2) Dec 25 16:29:16 volumio autossh[27607]: ssh child pid is 28038 Dec 25 16:29:16 volumio volumiossh-tunnel[28038]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:16 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:16 volumio autossh[27607]: starting ssh (count 3) Dec 25 16:29:16 volumio autossh[27607]: ssh child pid is 28039 Dec 25 16:29:16 volumio volumiossh-tunnel[28039]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:16 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:16 volumio autossh[27607]: starting ssh (count 4) Dec 25 16:29:16 volumio autossh[27607]: ssh child pid is 28040 Dec 25 16:29:16 volumio volumiossh-tunnel[28040]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:16 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:16 volumio autossh[27607]: starting ssh (count 5) Dec 25 16:29:16 volumio autossh[27607]: ssh child pid is 28041 Dec 25 16:29:16 volumio volumio[22542]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy1 [object Object] Dec 25 16:29:16 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy1 Dec 25 16:29:16 volumio volumio[22542]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 25 16:29:16 volumio volumio[22542]: info: PeppyMeterBasic -----------------------meter03G5_BlackBlur BC Dec 25 16:29:16 volumio volumio[22542]: info: PeppyMeterBasic -----------------------$basefolder/data/INTERNAL/PeppyMeterBasic/Templates Dec 25 16:29:16 volumio volumio[22542]: info: PeppyMeterBasic -----------------------screensize1920x480-Gelo5-BASIC_521 Dec 25 16:29:16 volumio volumio[22542]: info: PeppyMeterBasic -----------------------screenwidth1920 Dec 25 16:29:16 volumio volumio[22542]: info: PeppyMeterBasic -----------------------screenheight480 Dec 25 16:29:16 volumio volumio[22542]: info: PeppyMeterBasic -----------------------metersize30 Dec 25 16:29:16 volumio volumio[22542]: error: PeppyMeterBasic ---Error writing config null Dec 25 16:29:16 volumio sudo[28043]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart peppymeterbasic.service Dec 25 16:29:16 volumio sudo[28043]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:16 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 25 16:29:16 volumio volumiossh-tunnel[28041]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:17 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:17 volumio autossh[27607]: starting ssh (count 6) Dec 25 16:29:17 volumio autossh[27607]: ssh child pid is 28045 Dec 25 16:29:17 volumio volumio[22542]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 25 16:29:17 volumio volumio[22542]: info: CoreCommandRouter::Close All Modals sent Dec 25 16:29:17 volumio volumiossh-tunnel[28045]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:17 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:17 volumio autossh[27607]: starting ssh (count 7) Dec 25 16:29:17 volumio autossh[27607]: ssh child pid is 28046 Dec 25 16:29:17 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 25 16:29:17 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 25 16:29:17 volumio systemd[1]: peppymeterbasic.service: Consumed 2.699s CPU time. Dec 25 16:29:17 volumio volumiossh-tunnel[28046]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:17 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:17 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 25 16:29:17 volumio sudo[28043]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:17 volumio volumio[22542]: info: peppymeterbasic Daemon Started Dec 25 16:29:19 volumio autossh[27607]: starting ssh (count 8) Dec 25 16:29:19 volumio autossh[27607]: ssh child pid is 28062 Dec 25 16:29:19 volumio volumiossh-tunnel[28062]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:19 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:23 volumio volumio[22542]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy1 [object Object] Dec 25 16:29:23 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy1 Dec 25 16:29:23 volumio volumio[22542]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 25 16:29:23 volumio volumio[22542]: info: PeppyMeterBasic -----------------------meter15G5_Klanghelm_only Dec 25 16:29:23 volumio volumio[22542]: info: PeppyMeterBasic -----------------------$basefolder/data/INTERNAL/PeppyMeterBasic/Templates Dec 25 16:29:23 volumio volumio[22542]: info: PeppyMeterBasic -----------------------screensize1920x480-Gelo5-BASIC_521 Dec 25 16:29:23 volumio volumio[22542]: info: PeppyMeterBasic -----------------------screenwidth1920 Dec 25 16:29:23 volumio volumio[22542]: info: PeppyMeterBasic -----------------------screenheight480 Dec 25 16:29:23 volumio volumio[22542]: info: PeppyMeterBasic -----------------------metersize30 Dec 25 16:29:23 volumio volumio[22542]: error: PeppyMeterBasic ---Error writing config null Dec 25 16:29:23 volumio sudo[28067]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart peppymeterbasic.service Dec 25 16:29:23 volumio sudo[28067]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:23 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 25 16:29:23 volumio volumio[22542]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 25 16:29:23 volumio volumio[22542]: info: CoreCommandRouter::Close All Modals sent Dec 25 16:29:23 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 25 16:29:23 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 25 16:29:23 volumio systemd[1]: peppymeterbasic.service: Consumed 1.903s CPU time. Dec 25 16:29:23 volumio systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Dec 25 16:29:23 volumio sudo[28067]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:23 volumio volumio[22542]: info: peppymeterbasic Daemon Started Dec 25 16:29:27 volumio autossh[27607]: starting ssh (count 9) Dec 25 16:29:27 volumio autossh[27607]: ssh child pid is 28091 Dec 25 16:29:27 volumio volumiossh-tunnel[28091]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:27 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:31 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:31 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:33 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 25 16:29:33 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 25 16:29:37 volumio volumio[22542]: info: Stopping peppymeterbasic service Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::stop Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::stPlaybackTimer Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::updateTrackBlock Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrackBlock Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::pushState Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::volumioPushState Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::serviceStop Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::serviceStop Dec 25 16:29:37 volumio volumio[22542]: info: ControllerMpd::stop Dec 25 16:29:37 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand stop Dec 25 16:29:37 volumio volumio[22542]: info: Disabling plugin peppymeterbasic Dec 25 16:29:37 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:29:37 volumio volumio[22542]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 25 16:29:37 volumio volumio[22542]: info: Dec 25 16:29:37 volumio volumio[22542]: ---------------------------- MPD announces state update: player Dec 25 16:29:37 volumio volumio[22542]: info: sendMpdCommand stop took 41 milliseconds Dec 25 16:29:37 volumio volumio[22542]: info: ControllerMpd::getState Dec 25 16:29:37 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand status Dec 25 16:29:37 volumio sudo[28111]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 25 16:29:37 volumio sudo[28111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:29:37 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:29:37 volumio volumio[22542]: info: sendMpdCommand status took 8 milliseconds Dec 25 16:29:37 volumio volumio[22542]: verbose: ControllerMpd::parseState Dec 25 16:29:37 volumio volumio[22542]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 16:29:37 volumio sudo[28113]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 25 16:29:37 volumio sudo[28113]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio volumio[22542]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 25 16:29:37 volumio volumio[22542]: verbose: ControllerMpd::parseTrackInfo Dec 25 16:29:37 volumio volumio[22542]: info: ControllerMpd::pushState Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::servicePushState Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::pushState Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::volumioPushState Dec 25 16:29:37 volumio systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"02 Stille stille kommer vi.dff","artist":null,"album":null,"uri":"NAS/MUSIC/JAZZ/Hoff Ensemble - Quiet Winter Night.2012/02 Stille stille kommer vi.dff","trackType":"dff"} Dec 25 16:29:37 volumio volumio[22542]: verbose: CURRENT POSITION 1 Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::syncState stateService stop Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::syncState currentStatus stop Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::pushState Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::volumioPushState Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: info: No code Dec 25 16:29:37 volumio volumio[22542]: info: CoreStateMachine::pushState Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::volumioPushState Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio volumio[22542]: info: ------------------------------ 68ms Dec 25 16:29:37 volumio volumio[22542]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 25 16:29:37 volumio volumio[22542]: info: Asound.conf file written Dec 25 16:29:37 volumio sudo[28120]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 25 16:29:37 volumio sudo[28120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio sudo[28120]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:37 volumio systemd[1]: peppymeterbasic.service: Deactivated successfully. Dec 25 16:29:37 volumio systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Dec 25 16:29:37 volumio systemd[1]: peppymeterbasic.service: Consumed 2.327s CPU time. Dec 25 16:29:37 volumio sudo[28111]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:37 volumio volumio[22542]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 25 16:29:37 volumio volumio[22542]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 25 16:29:37 volumio volumio[22542]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Dec 25 16:29:37 volumio volumio[22542]: No state is present for card Loopback Dec 25 16:29:37 volumio volumio[22542]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Dec 25 16:29:37 volumio volumio[22542]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Dec 25 16:29:37 volumio volumio[22542]: Hardware is initialized using a generic method Dec 25 16:29:37 volumio volumio[22542]: No state is present for card Loopback Dec 25 16:29:37 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:29:37 volumio sudo[28113]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:37 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:37 volumio sudo[28126]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:29:37 volumio sudo[28126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio sudo[28126]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:37 volumio sudo[28128]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:29:37 volumio sudo[28128]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:29:37 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:37 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:37 volumio vtcs[23146]: [2025-12-25 16:29:37.318] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 25 16:29:37 volumio vtcs[23146]: [2025-12-25 16:29:37.319] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 25 16:29:37 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 25 16:29:37 volumio volumio[22542]: info: Done. Dec 25 16:29:37 volumio sudo[28138]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:37 volumio sudo[28138]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio sudo[28142]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:37 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 25 16:29:37 volumio sudo[28142]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 25 16:29:37 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 25 16:29:37 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:29:37 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:29:37 volumio systemd[1]: mpd.service: Consumed 2.631s CPU time. Dec 25 16:29:37 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:29:37 volumio volumio[22542]: info: peppymeterbasic Daemon Stop Dec 25 16:29:37 volumio sudo[28148]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:29:37 volumio sudo[28148]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio sudo[28138]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:37 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:29:37 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:29:37 volumio sudo[28148]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:37 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:29:37 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:29:37 volumio sudo[28157]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:29:37 volumio sudo[28157]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio sudo[28158]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:29:37 volumio sudo[28158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:37 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:29:37 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:29:37 volumio sudo[28142]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:37 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 25 16:29:37 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 25 16:29:37 volumio qobuz-connect[23100]: 20251225 16:29:37.489 [23100.23100] INFO SampleApp: Stopping Local configuration server Dec 25 16:29:37 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 25 16:29:37 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:37 volumio systemd[1]: shairport-sync.service: Consumed 4.019s CPU time. Dec 25 16:29:37 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:37 volumio sudo[28157]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:37 volumio volumio[22542]: info: Shairport-Sync Started Dec 25 16:29:37 volumio sudo[28162]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:29:37 volumio sudo[28162]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:37 volumio sudo[28162]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:38 volumio mpd[28166]: 2025-12-25T16:29:38 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 25 16:29:38 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 25 16:29:38 volumio sudo[28128]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:38 volumio volumio[22542]: error: updateQueue error: null Dec 25 16:29:38 volumio qobuz-connect[23100]: 20251225 16:29:38.476 [23100.23100] INFO SampleApp: shat down connection on UNIX socket Dec 25 16:29:38 volumio volumio[22542]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 25 16:29:38 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:29:38 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:38 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:38 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 25 16:29:38 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 25 16:29:38 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 25 16:29:38 volumio sudo[28158]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:38 volumio volumio[22542]: info: Executing endpoint qc_getconfig Dec 25 16:29:38 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 25 16:29:38 volumio qobuz-connect[28183]: 20251225 16:29:38.552 [28183.28183] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 25 16:29:38 volumio volumio[22542]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 25 16:29:38 volumio volumio[22542]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 25 16:29:38 volumio qobuz-connect[28183]: 20251225 16:29:38.554 [28183.28183] INFO VolumeManager: [0xe50098]: Setting new playback volume: 75 Dec 25 16:29:38 volumio qobuz-connect[28183]: 20251225 16:29:38.554 [28183.28183] INFO VolumeManager: [0xe50098]: Setting new mute state: 0 Dec 25 16:29:38 volumio qobuz-connect[28183]: 20251225 16:29:38.554 [28183.28183] INFO QobuzConnect: [0xe50a68]: Client initialized! Dec 25 16:29:38 volumio qobuz-connect[28183]: 20251225 16:29:38.554 [28183.28183] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 25 16:29:38 volumio qobuz-connect[28183]: 20251225 16:29:38.563 [28183.28183] INFO LocalConfigManager: [0xe4f978]: Starting Local Configuration server Dec 25 16:29:38 volumio qobuz-connect[28183]: 20251225 16:29:38.563 [28183.28183] INFO SampleApp: Starting Local configuration server Dec 25 16:29:38 volumio qobuz-connect[28183]: 20251225 16:29:38.563 [28183.28183] INFO SampleApp: Connected to UNIX socket client 0xe3a818 Dec 25 16:29:38 volumio qobuz-connect[28183]: 20251225 16:29:38.703 [28183.28183] INFO SampleApp: Playback volume changed: 75 Dec 25 16:29:38 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:38 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:40 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:29:40 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:29:40 volumio volumio[22542]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 25 16:29:40 volumio volumio[22542]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 25 16:29:40 volumio sudo[28201]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 25 16:29:40 volumio sudo[28201]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:40 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 25 16:29:40 volumio sudo[28201]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:40 volumio volumio[22542]: info: Executing endpoint tc_getconfig Dec 25 16:29:40 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 25 16:29:40 volumio vtcs[28204]: STARTING TidalConnect services, version: 1.5.2.56 Dec 25 16:29:40 volumio vtcs[28204]: STARTED TidalConnect services. Dec 25 16:29:40 volumio volumio[22542]: info: Executing endpoint tc_connect Dec 25 16:29:40 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 25 16:29:40 volumio volumio[22542]: info: Connecting to TidalConnect Dec 25 16:29:40 volumio volumio[22542]: info: CoreCommandRouter::servicePushState Dec 25 16:29:40 volumio volumio[22542]: info: CoreStateMachine::pushState Dec 25 16:29:40 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:40 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 16:29:40 volumio volumio[22542]: info: CoreCommandRouter::volumioPushState Dec 25 16:29:40 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:40 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:40 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:40 volumio volumio[22542]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Dec 25 16:29:40 volumio volumio[22542]: info: CoreCommandRouter::servicePushState Dec 25 16:29:40 volumio volumio[22542]: info: CoreStateMachine::pushState Dec 25 16:29:40 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:40 volumio volumio[22542]: info: CoreCommandRouter::volumioPushState Dec 25 16:29:40 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:40 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:40 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:40 volumio volumio[22542]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Dec 25 16:29:41 volumio sudo[28221]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 25 16:29:41 volumio sudo[28221]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:41 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 25 16:29:41 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 25 16:29:41 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 25 16:29:41 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 25 16:29:41 volumio sudo[28221]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:41 volumio mpd_monitor.sh[28223]: MPD Monitor Service: Starting MPD Monitor Service Dec 25 16:29:41 volumio volumio[22542]: info: Successfully started MPD Monitor Dec 25 16:29:43 volumio volumio[22542]: info: TidalConnect service started! Dec 25 16:29:45 volumio autossh[27607]: starting ssh (count 10) Dec 25 16:29:45 volumio autossh[27607]: ssh child pid is 28228 Dec 25 16:29:45 volumio volumiossh-tunnel[28228]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:45 volumio autossh[27607]: ssh exited with error status 255; restarting ssh Dec 25 16:29:45 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 25 16:29:46 volumio kernel: hwmon hwmon3: Voltage normalised Dec 25 16:29:48 volumio volumio[22542]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/peppyspectrum/1.0.39/volumio/bookworm/armhf Dec 25 16:29:48 volumio kernel: hwmon hwmon3: Undervoltage detected! Dec 25 16:29:48 volumio ntpd[1268]: PROTO: 185.211.244.47 unlink local addr 192.168.131.135 -> Dec 25 16:29:50 volumio volumio[22542]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/peppyspectrum/1.0.39/volumio/bookworm/armhf Dec 25 16:29:50 volumio volumio[22542]: info: Folder /tmp/plugins removed Dec 25 16:29:50 volumio volumio[22542]: info: Check plugin dependencies Dec 25 16:29:50 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 25 16:29:50 volumio volumio[22542]: info: Checking if plugin already exists Dec 25 16:29:50 volumio volumio[22542]: info: Rename folder Dec 25 16:29:50 volumio volumio[22542]: info: Folder /tmp/downloaded_plugin.zip removed Dec 25 16:29:50 volumio volumio[22542]: info: Move to category Dec 25 16:29:50 volumio volumio[22542]: info: Checking if install.sh is present Dec 25 16:29:50 volumio volumio[22542]: info: Executing install.sh Dec 25 16:29:50 volumio sudo[28265]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/peppyspectrum/install.sh Dec 25 16:29:50 volumio sudo[28265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:50 volumio volumio[22542]: info: Installing peppyalsa plugin dependencies Dec 25 16:29:50 volumio sudo[28269]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/usermod -aG render volumio Dec 25 16:29:50 volumio sudo[28269]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:50 volumio sudo[28269]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:50 volumio sudo[28274]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update Dec 25 16:29:50 volumio sudo[28274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:51 volumio volumio[22542]: info: Hit:1 https://deb.nodesource.com/node_20.x nodistro InRelease Dec 25 16:29:51 volumio volumio[22542]: info: Hit:2 http://archive.raspberrypi.com/debian bookworm InRelease Dec 25 16:29:51 volumio volumio[22542]: info: Hit:3 http://raspbian.raspberrypi.com/raspbian bookworm InRelease Dec 25 16:29:54 volumio volumio[22542]: info: Reading package lists... Dec 25 16:29:54 volumio sudo[28274]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:54 volumio sudo[28451]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chown -R volumio /data/plugins/user_interface/peppyspectrum /data/INTERNAL/PeppySpectrum/Templates Dec 25 16:29:54 volumio sudo[28451]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:54 volumio sudo[28451]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:54 volumio sudo[28453]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chgrp -R volumio /data/plugins/user_interface/peppyspectrum /data/INTERNAL/PeppySpectrum/Templates Dec 25 16:29:54 volumio sudo[28453]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:54 volumio sudo[28453]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:54 volumio volumio[22542]: info: installing apt packages Dec 25 16:29:54 volumio sudo[28455]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get -y install python3-pygame python3-pillow libfftw3-dev Dec 25 16:29:54 volumio sudo[28455]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:54 volumio volumio[22542]: info: Reading package lists... Dec 25 16:29:54 volumio ntpd[1268]: PROTO: 178.186.25.160 unlink local addr 192.168.131.135 -> Dec 25 16:29:55 volumio volumio[22542]: info: Building dependency tree... Dec 25 16:29:55 volumio volumio[22542]: info: Reading state information... Dec 25 16:29:55 volumio volumio[22542]: info: python3-pygame is already the newest version (2.1.2+dfsg-5). Dec 25 16:29:55 volumio sudo[28455]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:55 volumio volumio[22542]: info: python3-pil is already the newest version (9.4.0-1.1+deb12u1). Dec 25 16:29:55 volumio volumio[22542]: info: libfftw3-dev is already the newest version (3.3.10-1). Dec 25 16:29:55 volumio volumio[22542]: info: 0 upgraded, 0 newly installed, 0 to remove and 13 not upgraded. Dec 25 16:29:55 volumio sudo[28477]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/user_interface/peppyspectrum/startpeppyspectrum.sh Dec 25 16:29:55 volumio sudo[28477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:55 volumio sudo[28477]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:55 volumio volumio[22542]: info: Linked /data/plugins/user_interface/peppyspectrum/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppyspectrum/alsa-lib/libpeppyalsa.so Dec 25 16:29:55 volumio volumio[22542]: info: Linked /data/plugins/user_interface/peppyspectrum/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppyspectrum/alsa-lib/libpeppyalsa.so.0 Dec 25 16:29:55 volumio sudo[28479]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Dec 25 16:29:55 volumio sudo[28479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:55 volumio systemd[1]: Reloading. Dec 25 16:29:56 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 25 16:29:56 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 25 16:29:56 volumio sudo[28479]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:56 volumio sudo[28265]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:56 volumio volumio[22542]: Plugin install end detected on script Dec 25 16:29:56 volumio volumio[22542]: info: Install script completed Dec 25 16:29:56 volumio volumio[22542]: info: Adding reference to registry Dec 25 16:29:56 volumio volumio[22542]: info: Done installing plugin. Dec 25 16:29:56 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 25 16:29:56 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 25 16:29:56 volumio volumio[22542]: info: Folder /tmp/plugins removed Dec 25 16:29:56 volumio volumio[22542]: info: Folder /tmp/downloaded_plugin.zip removed Dec 25 16:29:56 volumio volumio[22542]: info: Folder /data/temp removed Dec 25 16:29:57 volumio volumio[22542]: info: Enabling plugin peppyspectrum Dec 25 16:29:57 volumio volumio[22542]: info: Loading plugin "peppyspectrum"... Dec 25 16:29:57 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:29:57 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:29:57 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:29:57 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:29:57 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:29:57 volumio sudo[28503]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:29:57 volumio sudo[28503]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:57 volumio sudo[28501]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:29:57 volumio sudo[28501]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:57 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:57 volumio sudo[28501]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:57 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 25 16:29:57 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:29:57 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:57 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:57 volumio vtcs[28204]: [2025-12-25 16:29:57.763] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 25 16:29:57 volumio vtcs[28204]: [2025-12-25 16:29:57.763] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 25 16:29:57 volumio volumio[22542]: info: PLUGIN START: peppyspectrum Dec 25 16:29:57 volumio sudo[28513]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:57 volumio sudo[28513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 25 16:29:57 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:29:57 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:29:57 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:29:57 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:29:57 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:29:57 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:29:57 volumio sudo[28517]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 25 16:29:57 volumio sudo[28517]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:57 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:29:57 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:29:57 volumio sudo[28517]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:57 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 25 16:29:57 volumio systemd[1]: vtcs.service: Deactivated successfully. Dec 25 16:29:57 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 25 16:29:57 volumio volumio[22542]: info: Done. Dec 25 16:29:57 volumio sudo[28513]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:57 volumio sudo[28522]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:57 volumio sudo[28522]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:57 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:29:57 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:29:57 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:29:57 volumio volumio[22542]: info: snd_dummy loaded Dec 25 16:29:57 volumio sudo[28529]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:29:57 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:29:57 volumio sudo[28529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:57 volumio sudo[28522]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:57 volumio volumio[22542]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio sudo[28519]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:29:57 volumio sudo[28519]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:57 volumio sudo[28519]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:57 volumio sudo[28529]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:57 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:57 volumio sudo[28538]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:29:57 volumio sudo[28538]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:57 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:29:58 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 25 16:29:58 volumio volumio[22542]: info: Asound.conf file written Dec 25 16:29:58 volumio qobuz-connect[28183]: 20251225 16:29:58.012 [28183.28183] INFO SampleApp: Stopping Local configuration server Dec 25 16:29:58 volumio sudo[28542]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:29:58 volumio sudo[28542]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28546]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 25 16:29:58 volumio sudo[28546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28546]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 25 16:29:58 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:58 volumio systemd[1]: shairport-sync.service: Consumed 1.545s CPU time. Dec 25 16:29:58 volumio volumio[22542]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 25 16:29:58 volumio volumio[22542]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 25 16:29:58 volumio volumio[22542]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Dec 25 16:29:58 volumio volumio[22542]: No state is present for card Loopback Dec 25 16:29:58 volumio volumio[22542]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Dec 25 16:29:58 volumio volumio[22542]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Dec 25 16:29:58 volumio volumio[22542]: Hardware is initialized using a generic method Dec 25 16:29:58 volumio volumio[22542]: No state is present for card Loopback Dec 25 16:29:58 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:29:58 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:58 volumio sudo[28553]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:29:58 volumio sudo[28553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:58 volumio sudo[28555]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:29:58 volumio sudo[28542]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28553]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28555]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:29:58 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:58 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:58 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:29:58 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:29:58 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:29:58 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:29:58 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:29:58 volumio sudo[28579]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:58 volumio sudo[28579]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28588]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:58 volumio sudo[28588]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:29:58 volumio volumio[22542]: info: Shairport-Sync Started Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio sudo[28595]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:29:58 volumio sudo[28595]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28579]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:29:58 volumio sudo[28604]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:29:58 volumio sudo[28604]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28595]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28584]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:29:58 volumio sudo[28584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:58 volumio sudo[28584]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28606]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:29:58 volumio sudo[28606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 25 16:29:58 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:58 volumio sudo[28588]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:58 volumio sudo[28604]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio volumio[22542]: info: Shairport-Sync Started Dec 25 16:29:58 volumio volumio[22542]: info: Enabling plugin peppyspectrum Dec 25 16:29:58 volumio volumio[22542]: info: Loading plugin "peppyspectrum"... Dec 25 16:29:58 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:29:58 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:29:58 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:29:58 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:29:58 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:29:58 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:29:58 volumio sudo[28627]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:29:58 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:58 volumio sudo[28627]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28629]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:29:58 volumio sudo[28627]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28629]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:29:58 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:58 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:58 volumio volumio[22542]: info: PLUGIN START: peppyspectrum Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 25 16:29:58 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:29:58 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:29:58 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:29:58 volumio sudo[28639]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:58 volumio sudo[28639]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:29:58 volumio sudo[28641]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 25 16:29:58 volumio sudo[28641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28641]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio volumio[22542]: info: Done. Dec 25 16:29:58 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:29:58 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:29:58 volumio sudo[28646]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:58 volumio sudo[28646]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:29:58 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:29:58 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:29:58 volumio volumio[22542]: info: snd_dummy loaded Dec 25 16:29:58 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:29:58 volumio sudo[28654]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:29:58 volumio volumio[22542]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Dec 25 16:29:58 volumio sudo[28654]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:29:58 volumio sudo[28646]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28662]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:29:58 volumio sudo[28662]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:29:58 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:29:58 volumio qobuz-connect[28183]: 20251225 16:29:58.592 [28183.28183] INFO SampleApp: shat down connection on UNIX socket Dec 25 16:29:58 volumio sudo[28649]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:29:58 volumio sudo[28649]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:58 volumio sudo[28649]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 25 16:29:58 volumio sudo[28639]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28654]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:58 volumio sudo[28667]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:29:58 volumio sudo[28667]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28667]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28672]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:29:58 volumio sudo[28672]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28673]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:29:58 volumio sudo[28673]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:29:58 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:58 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:58 volumio sudo[28684]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:58 volumio sudo[28684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28688]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:58 volumio sudo[28688]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 25 16:29:58 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 25 16:29:58 volumio sudo[28606]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28538]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:29:58 volumio volumio[22542]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 25 16:29:58 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:58 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:58 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:58 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:29:58 volumio volumio[22542]: info: Tunnel connection is inactive, restarting it Dec 25 16:29:58 volumio volumio[22542]: info: Starting Tunnel 1 Dec 25 16:29:58 volumio volumio[22542]: info: Starting Tunnel Connection Checker Dec 25 16:29:58 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio sudo[28697]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:29:58 volumio sudo[28697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:58 volumio sudo[28672]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio volumio[22542]: info: Executing endpoint qc_getconfig Dec 25 16:29:58 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 25 16:29:58 volumio qobuz-connect[28690]: 20251225 16:29:58.796 [28690.28690] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 25 16:29:58 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:29:58 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:29:58 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:29:58 volumio volumio[22542]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 25 16:29:58 volumio volumio[22542]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 25 16:29:58 volumio qobuz-connect[28690]: 20251225 16:29:58.805 [28690.28690] INFO VolumeManager: [0x1fac098]: Setting new playback volume: 75 Dec 25 16:29:58 volumio qobuz-connect[28690]: 20251225 16:29:58.805 [28690.28690] INFO VolumeManager: [0x1fac098]: Setting new mute state: 0 Dec 25 16:29:58 volumio qobuz-connect[28690]: 20251225 16:29:58.805 [28690.28690] INFO QobuzConnect: [0x1faca68]: Client initialized! Dec 25 16:29:58 volumio qobuz-connect[28690]: 20251225 16:29:58.805 [28690.28690] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 25 16:29:58 volumio sudo[28697]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio qobuz-connect[28690]: 20251225 16:29:58.817 [28690.28690] INFO LocalConfigManager: [0x1fab978]: Starting Local Configuration server Dec 25 16:29:58 volumio qobuz-connect[28690]: 20251225 16:29:58.817 [28690.28690] INFO SampleApp: Starting Local configuration server Dec 25 16:29:58 volumio qobuz-connect[28690]: 20251225 16:29:58.817 [28690.28690] INFO SampleApp: Connected to UNIX socket client 0x1f96818 Dec 25 16:29:58 volumio sudo[28715]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:29:58 volumio sudo[28715]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28716]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:29:58 volumio sudo[28716]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:29:58 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:29:58 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:58 volumio sudo[28662]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio volumio[22542]: info: Shairport-Sync Started Dec 25 16:29:58 volumio sudo[28688]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio sudo[28684]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 25 16:29:58 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 25 16:29:58 volumio qobuz-connect[28690]: 20251225 16:29:58.938 [28690.28690] INFO SampleApp: Stopping Local configuration server Dec 25 16:29:58 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 25 16:29:58 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:58 volumio sudo[28721]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:29:58 volumio sudo[28721]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:58 volumio sudo[28721]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:58 volumio sudo[28742]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Dec 25 16:29:58 volumio sudo[28742]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:58 volumio sudo[28715]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:58 volumio volumio[22542]: info: Shairport-Sync Started Dec 25 16:29:59 volumio autossh[27607]: signalled to exit Dec 25 16:29:59 volumio systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Deactivated successfully. Dec 25 16:29:59 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:29:59 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:29:59 volumio autossh[28761]: port set to 0, monitoring disabled Dec 25 16:29:59 volumio autossh[28761]: starting ssh (count 1) Dec 25 16:29:59 volumio autossh[28761]: ssh child pid is 28764 Dec 25 16:29:59 volumio sudo[28742]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio volumio[22542]: info: Remote SSH Started Dec 25 16:29:59 volumio volumio[22542]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:59 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:59 volumio volumiossh-tunnel[28764]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:59 volumio autossh[28761]: ssh exited prematurely with status 255; autossh exiting Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 1. Dec 25 16:29:59 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:29:59 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:29:59 volumio autossh[28766]: port set to 0, monitoring disabled Dec 25 16:29:59 volumio autossh[28766]: starting ssh (count 1) Dec 25 16:29:59 volumio autossh[28766]: ssh child pid is 28769 Dec 25 16:29:59 volumio volumiossh-tunnel[28769]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:59 volumio autossh[28766]: ssh exited prematurely with status 255; autossh exiting Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Dec 25 16:29:59 volumio volumio[22542]: info: Enabling plugin peppyspectrum Dec 25 16:29:59 volumio volumio[22542]: info: Loading plugin "peppyspectrum"... Dec 25 16:29:59 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:29:59 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:29:59 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:29:59 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:29:59 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:29:59 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:29:59 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:59 volumio sudo[28771]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:29:59 volumio sudo[28771]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio sudo[28773]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:29:59 volumio sudo[28773]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio sudo[28771]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:29:59 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:59 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:59 volumio volumio[22542]: info: PLUGIN START: peppyspectrum Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 25 16:29:59 volumio sudo[28783]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:59 volumio sudo[28783]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 2. Dec 25 16:29:59 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:29:59 volumio sudo[28785]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 25 16:29:59 volumio sudo[28785]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio volumio[22542]: info: Done. Dec 25 16:29:59 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:29:59 volumio sudo[28785]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio sudo[28790]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:59 volumio sudo[28790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:29:59 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:29:59 volumio autossh[28796]: port set to 0, monitoring disabled Dec 25 16:29:59 volumio autossh[28796]: starting ssh (count 1) Dec 25 16:29:59 volumio autossh[28796]: ssh child pid is 28801 Dec 25 16:29:59 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:29:59 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:29:59 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:29:59 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:29:59 volumio volumio[22542]: info: snd_dummy loaded Dec 25 16:29:59 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:29:59 volumio sudo[28800]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:29:59 volumio volumio[22542]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Dec 25 16:29:59 volumio sudo[28800]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:29:59 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:29:59 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumiossh-tunnel[28801]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:29:59 volumio autossh[28796]: ssh exited prematurely with status 255; autossh exiting Dec 25 16:29:59 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Dec 25 16:29:59 volumio sudo[28800]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio sudo[28783]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio sudo[28790]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:29:59 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:29:59 volumio sudo[28811]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:29:59 volumio sudo[28811]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio sudo[28806]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:29:59 volumio sudo[28806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:29:59 volumio sudo[28812]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:29:59 volumio sudo[28812]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio sudo[28806]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:59 volumio sudo[28817]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:29:59 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 25 16:29:59 volumio sudo[28817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 25 16:29:59 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:59 volumio sudo[28817]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio sudo[28821]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:29:59 volumio sudo[28821]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:29:59 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:29:59 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:29:59 volumio sudo[28832]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:59 volumio sudo[28832]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio sudo[28838]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:29:59 volumio sudo[28838]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 3. Dec 25 16:29:59 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio sudo[28845]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:29:59 volumio sudo[28845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:29:59 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:29:59 volumio sudo[28853]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:29:59 volumio sudo[28853]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio sudo[28845]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio sudo[28855]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:29:59 volumio sudo[28855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:29:59 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 25 16:29:59 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:29:59 volumio sudo[28811]: pam_unix(sudo:session): session closed for user root Dec 25 16:29:59 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:29:59 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:30:00 volumio volumio[22542]: info: Shairport-Sync Started Dec 25 16:30:00 volumio autossh[28866]: port set to 0, monitoring disabled Dec 25 16:30:00 volumio autossh[28866]: starting ssh (count 1) Dec 25 16:30:00 volumio autossh[28866]: ssh child pid is 28873 Dec 25 16:30:00 volumio volumio[22542]: (node:22542) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 25 16:30:00 volumio volumio[22542]: (Use `node --trace-warnings ...` to show where the warning was created) Dec 25 16:30:00 volumio volumio[22542]: (node:22542) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 25 16:30:00 volumio volumio[22542]: (node:22542) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 25 16:30:00 volumio volumio[22542]: (node:22542) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 25 16:30:00 volumio volumio[22542]: (node:22542) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 25 16:30:00 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:30:00 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:30:00 volumio volumiossh-tunnel[28873]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:30:00 volumio autossh[28866]: ssh exited prematurely with status 255; autossh exiting Dec 25 16:30:00 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Dec 25 16:30:00 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Dec 25 16:30:00 volumio sudo[28832]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio sudo[28838]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: Enabling plugin peppyspectrum Dec 25 16:30:00 volumio volumio[22542]: info: Loading plugin "peppyspectrum"... Dec 25 16:30:00 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:00 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:00 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:00 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:00 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:30:00 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:30:00 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:30:00 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:00 volumio sudo[28895]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:30:00 volumio sudo[28895]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28897]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:30:00 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:30:00 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio sudo[28897]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:30:00 volumio sudo[28895]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:00 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:30:00 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 25 16:30:00 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 25 16:30:00 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:30:00 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 4. Dec 25 16:30:00 volumio volumio[22542]: info: PLUGIN START: peppyspectrum Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 25 16:30:00 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 25 16:30:00 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 25 16:30:00 volumio systemd[1]: Failed to start shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:30:00 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:30:00 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:00 volumio sudo[28910]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 25 16:30:00 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:30:00 volumio volumio[22542]: info: Done. Dec 25 16:30:00 volumio autossh[28912]: port set to 0, monitoring disabled Dec 25 16:30:00 volumio autossh[28912]: starting ssh (count 1) Dec 25 16:30:00 volumio autossh[28912]: ssh child pid is 28915 Dec 25 16:30:00 volumio sudo[28853]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio sudo[28910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28908]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:00 volumio sudo[28908]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:30:00 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:30:00 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:30:00 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:30:00 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:30:00 volumio sudo[28919]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:00 volumio sudo[28919]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28910]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:30:00 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:30:00 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:00 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:00 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:00 volumio volumio[22542]: info: snd_dummy loaded Dec 25 16:30:00 volumio sudo[28929]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:30:00 volumio sudo[28929]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:30:00 volumio volumio[22542]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 25 16:30:00 volumio volumio[22542]: Job for shairport-sync.service failed because start of the service was attempted too often. Dec 25 16:30:00 volumio volumio[22542]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Dec 25 16:30:00 volumio volumio[22542]: To force a start use "systemctl reset-failed shairport-sync.service" Dec 25 16:30:00 volumio volumio[22542]: followed by "systemctl start shairport-sync.service" again. Dec 25 16:30:00 volumio volumio[22542]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumiossh-tunnel[28915]: ssh: connect to host eu7.myvolumio.org port 2222: Connection refused Dec 25 16:30:00 volumio autossh[28912]: ssh exited prematurely with status 255; autossh exiting Dec 25 16:30:00 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Dec 25 16:30:00 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio sudo[28929]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:30:00 volumio sudo[28937]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:30:00 volumio sudo[28937]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:30:00 volumio sudo[28927]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:30:00 volumio sudo[28927]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:30:00 volumio sudo[28940]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:30:00 volumio sudo[28940]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28927]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio sudo[28908]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:00 volumio sudo[28944]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:30:00 volumio sudo[28944]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28944]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:30:00 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:00 volumio sudo[28947]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:30:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:00 volumio sudo[28947]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28958]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:00 volumio sudo[28958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28964]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:00 volumio sudo[28964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28919]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 5. Dec 25 16:30:00 volumio volumio[22542]: info: Enabling plugin peppyspectrum Dec 25 16:30:00 volumio volumio[22542]: info: Loading plugin "peppyspectrum"... Dec 25 16:30:00 volumio sudo[28972]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:30:00 volumio sudo[28972]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:00 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:30:00 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:00 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:00 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:30:00 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:30:00 volumio sudo[28972]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 25 16:30:00 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 25 16:30:00 volumio systemd[1]: Failed to start shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:30:00 volumio sudo[28980]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:30:00 volumio sudo[28980]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:00 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:30:00 volumio systemd[1]: sshtunnel.service: Start request repeated too quickly. Dec 25 16:30:00 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Dec 25 16:30:00 volumio systemd[1]: Failed to start sshtunnel.service - MyVolumio SSH Tunnel. Dec 25 16:30:00 volumio sudo[28982]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:30:00 volumio sudo[28982]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:30:00 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio sudo[28987]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:30:00 volumio sudo[28982]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio sudo[28987]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28985]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:30:00 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:30:00 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:30:00 volumio sudo[28985]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:00 volumio volumio[22542]: info: PLUGIN START: peppyspectrum Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 25 16:30:00 volumio sudo[28997]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:00 volumio sudo[28940]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio sudo[28997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:00 volumio sudo[28958]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio sudo[28999]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 25 16:30:00 volumio sudo[28999]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Done. Dec 25 16:30:00 volumio sudo[28999]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio sudo[29004]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:00 volumio sudo[29004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Enabling plugin peppyspectrum Dec 25 16:30:00 volumio volumio[22542]: info: Loading plugin "peppyspectrum"... Dec 25 16:30:00 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:00 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:00 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:00 volumio sudo[28964]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: snd_dummy loaded Dec 25 16:30:00 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:30:00 volumio volumio[22542]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 25 16:30:00 volumio volumio[22542]: Job for shairport-sync.service failed because start of the service was attempted too often. Dec 25 16:30:00 volumio volumio[22542]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Dec 25 16:30:00 volumio volumio[22542]: To force a start use "systemctl reset-failed shairport-sync.service" Dec 25 16:30:00 volumio volumio[22542]: followed by "systemctl start shairport-sync.service" again. Dec 25 16:30:00 volumio volumio[22542]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio sudo[29011]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio sudo[29011]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:30:00 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:30:00 volumio sudo[29020]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:30:00 volumio sudo[29020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:00 volumio sudo[29023]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:30:00 volumio sudo[29023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[29025]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:30:00 volumio sudo[29025]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:30:00 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio sudo[29023]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:00 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:30:00 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:30:00 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:30:00 volumio sudo[29011]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:00 volumio sudo[29037]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:00 volumio sudo[29037]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:30:00 volumio sudo[29036]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:30:00 volumio sudo[29036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:30:00 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 25 16:30:00 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 25 16:30:00 volumio systemd[1]: Failed to start shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:30:00 volumio qobuz-connect[28690]: 20251225 16:30:00.829 [28690.28690] INFO SampleApp: shat down connection on UNIX socket Dec 25 16:30:00 volumio sudo[29044]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:00 volumio sudo[29044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 25 16:30:00 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 25 16:30:00 volumio volumio[22542]: info: Enabling plugin peppyspectrum Dec 25 16:30:00 volumio volumio[22542]: info: Loading plugin "peppyspectrum"... Dec 25 16:30:00 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:00 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:00 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:00 volumio sudo[28980]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:30:00 volumio volumio[22542]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 25 16:30:00 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:00 volumio volumio[22542]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 25 16:30:00 volumio volumio[22542]: Job for shairport-sync.service failed because start of the service was attempted too often. Dec 25 16:30:00 volumio volumio[22542]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Dec 25 16:30:00 volumio volumio[22542]: To force a start use "systemctl reset-failed shairport-sync.service" Dec 25 16:30:00 volumio volumio[22542]: followed by "systemctl start shairport-sync.service" again. Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio sudo[29052]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:30:00 volumio sudo[29052]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[28997]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:30:00 volumio volumio[22542]: info: Enabling plugin peppyspectrum Dec 25 16:30:00 volumio volumio[22542]: info: Loading plugin "peppyspectrum"... Dec 25 16:30:00 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:30:00 volumio sudo[29040]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:30:00 volumio sudo[29040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:30:00 volumio sudo[29040]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:30:00 volumio sudo[29062]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:30:00 volumio sudo[29062]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:00 volumio sudo[29066]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:30:00 volumio sudo[29066]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio sudo[29066]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio sudo[29068]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:30:00 volumio sudo[29068]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:30:00 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:00 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:00 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:00 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:00 volumio sudo[29004]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:00 volumio volumio[22542]: info: PLUGIN START: peppyspectrum Dec 25 16:30:00 volumio sudo[29078]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:00 volumio sudo[29078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:00 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 25 16:30:01 volumio volumio[22542]: info: Done. Dec 25 16:30:01 volumio sudo[29082]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 25 16:30:01 volumio sudo[29082]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29082]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29085]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:01 volumio sudo[29085]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:01 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:01 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:01 volumio sudo[29092]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:30:01 volumio sudo[29092]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: snd_dummy loaded Dec 25 16:30:01 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:30:01 volumio sudo[29052]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:30:01 volumio sudo[29094]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:30:01 volumio sudo[29094]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Dec 25 16:30:01 volumio sudo[29092]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio sudo[29101]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:30:01 volumio sudo[29101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 25 16:30:01 volumio volumio[22542]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 25 16:30:01 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:30:01 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 25 16:30:01 volumio sudo[29113]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:30:01 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 25 16:30:01 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 25 16:30:01 volumio systemd[1]: Failed to start shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:30:01 volumio sudo[28937]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[28985]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[28812]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29113]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29036]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[28716]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[28855]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:30:01 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:30:01 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:30:01 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:30:01 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:01 volumio sudo[29116]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 25 16:30:01 volumio sudo[29116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29118]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:30:01 volumio sudo[29118]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29118]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29120]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:30:01 volumio sudo[29120]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:30:01 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:01 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:01 volumio sudo[29020]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:01 volumio sudo[29131]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:01 volumio sudo[29131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29062]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: PLUGIN START: peppyspectrum Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 25 16:30:01 volumio volumio[22542]: info: Done. Dec 25 16:30:01 volumio sudo[29134]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 25 16:30:01 volumio sudo[29134]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29134]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29137]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:01 volumio sudo[29137]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29094]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29037]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:01 volumio sudo[29144]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:30:01 volumio sudo[29144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:01 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:01 volumio sudo[29078]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: Executing endpoint qc_getconfig Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 25 16:30:01 volumio volumio[22542]: info: snd_dummy loaded Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.343 [29110.29110] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 25 16:30:01 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:30:01 volumio volumio[22542]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 25 16:30:01 volumio volumio[22542]: Job for shairport-sync.service failed because start of the service was attempted too often. Dec 25 16:30:01 volumio volumio[22542]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Dec 25 16:30:01 volumio volumio[22542]: To force a start use "systemctl reset-failed shairport-sync.service" Dec 25 16:30:01 volumio volumio[22542]: followed by "systemctl start shairport-sync.service" again. Dec 25 16:30:01 volumio volumio[22542]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 25 16:30:01 volumio volumio[22542]: Job for shairport-sync.service failed because start of the service was attempted too often. Dec 25 16:30:01 volumio volumio[22542]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Dec 25 16:30:01 volumio volumio[22542]: To force a start use "systemctl reset-failed shairport-sync.service" Dec 25 16:30:01 volumio volumio[22542]: followed by "systemctl start shairport-sync.service" again. Dec 25 16:30:01 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:30:01 volumio volumio[22542]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.347 [29110.29110] INFO VolumeManager: [0x1ac6098]: Setting new playback volume: 75 Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.347 [29110.29110] INFO VolumeManager: [0x1ac6098]: Setting new mute state: 0 Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.347 [29110.29110] INFO QobuzConnect: [0x1ac6a68]: Client initialized! Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.347 [29110.29110] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 25 16:30:01 volumio volumio[22542]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 25 16:30:01 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.358 [29110.29110] INFO LocalConfigManager: [0x1ac5978]: Starting Local Configuration server Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.358 [29110.29110] INFO SampleApp: Starting Local configuration server Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.358 [29110.29110] INFO SampleApp: Connected to UNIX socket client 0x1ab0818 Dec 25 16:30:01 volumio sudo[29085]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio sudo[29044]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:30:01 volumio volumio[22542]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 25 16:30:01 volumio volumio[22542]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 25 16:30:01 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:30:01 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:30:01 volumio sudo[29169]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:30:01 volumio sudo[29169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:01 volumio sudo[29174]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:30:01 volumio sudo[29174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29176]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:30:01 volumio sudo[29176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29174]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:30:01 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:01 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:01 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:01 volumio volumio[22542]: info: PLUGIN START: peppyspectrum Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 25 16:30:01 volumio sudo[29186]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:01 volumio sudo[29186]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29116]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: Done. Dec 25 16:30:01 volumio sudo[29189]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Dec 25 16:30:01 volumio sudo[29189]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29189]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29144]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.493 [29110.29110] INFO SampleApp: Playback volume changed: 75 Dec 25 16:30:01 volumio sudo[29192]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:01 volumio sudo[29192]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29195]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:30:01 volumio sudo[29195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:30:01 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:30:01 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:30:01 volumio mpd_monitor.sh[29172]: MPD error: Connection reset by peer Dec 25 16:30:01 volumio mpd_monitor.sh[28223]: MPD Monitor Service: MPD Appears to be inactive, restarting Dec 25 16:30:01 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:01 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:01 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:01 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:01 volumio volumio[22542]: info: snd_dummy loaded Dec 25 16:30:01 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:30:01 volumio volumio[22542]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl start vtcs.service && sleep 3 Dec 25 16:30:01 volumio volumio[22542]: Job for vtcs.service canceled. Dec 25 16:30:01 volumio volumio[22542]: {"cmd":"/usr/bin/sudo /bin/systemctl start vtcs.service && sleep 3","code":1,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl start vtcs.service && sleep 3\nJob for vtcs.service canceled.\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)","stderr":"Job for vtcs.service canceled.\n","stdout":""} Dec 25 16:30:01 volumio mpd_monitor.sh[29203]: mpd: no process found Dec 25 16:30:01 volumio sudo[29202]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:30:01 volumio sudo[29202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio sudo[29205]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 25 16:30:01 volumio sudo[29205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:30:01 volumio qobuz-connect[29110]: 20251225 16:30:01.563 [29110.29110] INFO SampleApp: Stopping Local configuration server Dec 25 16:30:01 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 25 16:30:01 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 25 16:30:01 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 25 16:30:01 volumio systemd[1]: Failed to start shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:30:01 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:30:01 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:30:01 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:30:01 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:01 volumio sudo[29216]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:30:01 volumio sudo[29216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29218]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:30:01 volumio sudo[29218]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29169]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29218]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:30:01 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:01 volumio sudo[29113]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:01 volumio sudo[29214]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:30:01 volumio sudo[29214]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:30:01 volumio sudo[29137]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29214]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:01 volumio sudo[29221]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:30:01 volumio sudo[29221]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29231]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:01 volumio sudo[29231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29186]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29131]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29242]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:01 volumio sudo[29242]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:30:01 volumio sudo[29249]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:30:01 volumio sudo[29249]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:01 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:01 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:01 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:30:01 volumio volumio[22542]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 25 16:30:01 volumio volumio[22542]: Job for shairport-sync.service failed because start of the service was attempted too often. Dec 25 16:30:01 volumio volumio[22542]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Dec 25 16:30:01 volumio volumio[22542]: To force a start use "systemctl reset-failed shairport-sync.service" Dec 25 16:30:01 volumio volumio[22542]: followed by "systemctl start shairport-sync.service" again. Dec 25 16:30:01 volumio volumio[22542]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 25 16:30:01 volumio volumio[22542]: Job for shairport-sync.service failed because start of the service was attempted too often. Dec 25 16:30:01 volumio volumio[22542]: See "systemctl status shairport-sync.service" and "journalctl -xeu shairport-sync.service" for details. Dec 25 16:30:01 volumio volumio[22542]: To force a start use "systemctl reset-failed shairport-sync.service" Dec 25 16:30:01 volumio volumio[22542]: followed by "systemctl start shairport-sync.service" again. Dec 25 16:30:01 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 25 16:30:01 volumio volumio[22542]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 25 16:30:01 volumio volumio[22542]: info: Starting Shairport Sync Dec 25 16:30:01 volumio volumio[22542]: info: Asound.conf file unchanged, so no further update is needed Dec 25 16:30:01 volumio volumio[22542]: info: Output device has changed, restarting MPD Dec 25 16:30:01 volumio sudo[29265]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 16:30:01 volumio sudo[29265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29267]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 25 16:30:01 volumio sudo[29267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29202]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29269]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 16:30:01 volumio volumio[22542]: info: Output device has changed, restarting Shairport Sync Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:01 volumio sudo[29269]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29269]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29273]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:30:01 volumio sudo[29273]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29192]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio sudo[29274]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 16:30:01 volumio sudo[29274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio volumio[22542]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 16:30:01 volumio volumio[22542]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:01 volumio volumio[22542]: info: QobuzConnect: setDeactiveState invoked Dec 25 16:30:01 volumio volumio[22542]: info: CoreCommandRouter::volumioGetState Dec 25 16:30:01 volumio volumio[22542]: info: CorePlayQueue::getTrack 1 Dec 25 16:30:01 volumio volumio[22542]: info: Preparing to generate the ALSA configuration file Dec 25 16:30:01 volumio sudo[29285]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:01 volumio sudo[29285]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29292]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 16:30:01 volumio sudo[29292]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:01 volumio sudo[29205]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 16:30:01 volumio volumio[22542]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 25 16:30:01 volumio volumio[22542]: info: Reading ALSA contributions from plugins. Dec 25 16:30:01 volumio volumio[22542]: info: MPD Permissions set Dec 25 16:30:01 volumio sudo[29249]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:01 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:30:01 volumio volumio[22542]: info: TidalConnect service stoped! Dec 25 16:30:01 volumio volumio[22542]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Dec 25 16:30:01 volumio volumio[22542]: Job for vtcs.service canceled. Dec 25 16:30:01 volumio volumio[22542]: {"cmd":"/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3","code":1,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3\nJob for vtcs.service canceled.\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)","stderr":"Job for vtcs.service canceled.\n","stdout":""} Dec 25 16:30:02 volumio volumio[22542]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl start vtcs.service && sleep 3 Dec 25 16:30:02 volumio volumio[22542]: Job for vtcs.service canceled. Dec 25 16:30:02 volumio volumio[22542]: {"cmd":"/usr/bin/sudo /bin/systemctl start vtcs.service && sleep 3","code":1,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl start vtcs.service && sleep 3\nJob for vtcs.service canceled.\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)","stderr":"Job for vtcs.service canceled.\n","stdout":""} Dec 25 16:30:02 volumio sudo[29298]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 16:30:02 volumio sudo[29298]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:02 volumio sudo[29300]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:30:02 volumio sudo[29300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:02 volumio sudo[29231]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 16:30:02 volumio volumio[22542]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 16:30:02 volumio sudo[29242]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:02 volumio volumio[22542]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 16:30:02 volumio volumio[22542]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Dec 25 16:30:02 volumio volumio[22542]: Job for vtcs.service canceled. Dec 25 16:30:02 volumio volumio[22542]: at ChildProcess.exithandler (node:child_process:421:12) Dec 25 16:30:02 volumio volumio[22542]: at ChildProcess.emit (node:events:514:28) Dec 25 16:30:02 volumio volumio[22542]: at maybeClose (node:internal/child_process:1105:16) Dec 25 16:30:02 volumio volumio[22542]: at Socket. (node:internal/child_process:457:11) Dec 25 16:30:02 volumio volumio[22542]: at Socket.emit (node:events:514:28) Dec 25 16:30:02 volumio volumio[22542]: at Pipe. (node:net:337:12) { Dec 25 16:30:02 volumio volumio[22542]: code: 1, Dec 25 16:30:02 volumio volumio[22542]: killed: false, Dec 25 16:30:02 volumio volumio[22542]: signal: null, Dec 25 16:30:02 volumio volumio[22542]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Dec 25 16:30:02 volumio volumio[22542]: stdout: '', Dec 25 16:30:02 volumio volumio[22542]: stderr: 'Job for vtcs.service canceled.\n' Dec 25 16:30:02 volumio volumio[22542]: } Dec 25 16:30:02 volumio volumio[22542]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 16:30:02 volumio sudo[29267]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:02 volumio sudo[29298]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:02 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 25 16:30:02 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 25 16:30:02 volumio systemd[1]: Failed to start shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 25 16:30:02 volumio sudo[29322]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 16:30:02 volumio sudo[29322]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 16:30:02 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 25 16:30:02 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 25 16:30:02 volumio sudo[29216]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:02 volumio sudo[29265]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:02 volumio sudo[29292]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:02 volumio sudo[29285]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:02 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 25 16:30:02 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 25 16:30:02 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 25 16:30:02 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 25 16:30:02 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 25 16:30:02 volumio sudo[29328]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 16:30:02 volumio sudo[29328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 25 16:30:02 volumio sudo[29328]: pam_unix(sudo:session): session closed for user root Dec 25 16:30:02 volumio sudo[29338]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-25 16:29' Dec 25 16:30:02 volumio sudo[29338]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"