-- Logs begin at Sat 2025-04-26 12:23:54 EDT, end at Sat 2025-04-26 12:28:59 EDT. -- Apr 26 12:27:00 volumio volumio[1379]: error: Failed request for metavolumio API Apr 26 12:27:06 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 26 12:27:09 volumio volumio[1379]: info: VolumeController::SetAlsaVolume60 Apr 26 12:27:09 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:27:09 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 12:27:09 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:27:09 volumio volumio[1379]: info: [ASDebug] CurState: play PrevState: play Apr 26 12:27:09 volumio volumio[1379]: info: [GPIO_Control] Status changed: play Apr 26 12:27:09 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 26 12:27:09 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status play Apr 26 12:27:09 volumio sudo[23297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 26 12:27:09 volumio sudo[23297]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:09 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Apr 26 12:27:09 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 55 Apr 26 12:27:09 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 60 Apr 26 12:27:09 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 26 12:27:09 volumio volumio[1379]: info: Setting Spotify Volume from Volumio: 60 Apr 26 12:27:09 volumio sudo[23297]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:09 volumio sudo[23300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Apr 26 12:27:09 volumio sudo[23300]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:09 volumio volumio[1379]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 26 12:27:09 volumio volumio[1379]: info: peppymeterbasic Daemon Started Apr 26 12:27:09 volumio sudo[23300]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:09 volumio volumio[1379]: info: peppyspectrum Daemon Started Apr 26 12:27:10 volumio volumio[1379]: info: VolumeController::SetAlsaVolume75 Apr 26 12:27:10 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:27:10 volumio volumio[1379]: info: [ASDebug] CurState: play PrevState: play Apr 26 12:27:10 volumio volumio[1379]: info: [GPIO_Control] Status changed: play Apr 26 12:27:10 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 26 12:27:10 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status play Apr 26 12:27:10 volumio sudo[23360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 26 12:27:10 volumio sudo[23360]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 60 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 75 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 26 12:27:10 volumio volumio[1379]: info: Setting Spotify Volume from Volumio: 75 Apr 26 12:27:10 volumio volumio[1379]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 26 12:27:10 volumio sudo[23360]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio sudo[23363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Apr 26 12:27:10 volumio sudo[23363]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio sudo[23363]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio volumio[1379]: info: peppyspectrum Daemon Started Apr 26 12:27:10 volumio volumio[1379]: info: peppymeterbasic Daemon Started Apr 26 12:27:10 volumio volumio[1379]: info: VolumeController::SetAlsaVolume78 Apr 26 12:27:10 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:27:10 volumio volumio[1379]: info: [ASDebug] CurState: play PrevState: play Apr 26 12:27:10 volumio volumio[1379]: info: [GPIO_Control] Status changed: play Apr 26 12:27:10 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 26 12:27:10 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status play Apr 26 12:27:10 volumio sudo[23396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 26 12:27:10 volumio sudo[23396]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 75 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 78 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 26 12:27:10 volumio volumio[1379]: info: Setting Spotify Volume from Volumio: 78 Apr 26 12:27:10 volumio volumio[1379]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 26 12:27:10 volumio sudo[23399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Apr 26 12:27:10 volumio sudo[23399]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio sudo[23396]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio sudo[23399]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio volumio[1379]: info: peppymeterbasic Daemon Started Apr 26 12:27:10 volumio volumio[1379]: info: peppyspectrum Daemon Started Apr 26 12:27:10 volumio volumio[1379]: info: VolumeController::SetAlsaVolume80 Apr 26 12:27:10 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:27:10 volumio volumio[1379]: info: [ASDebug] CurState: play PrevState: play Apr 26 12:27:10 volumio volumio[1379]: info: [GPIO_Control] Status changed: play Apr 26 12:27:10 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 26 12:27:10 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status play Apr 26 12:27:10 volumio sudo[23424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 26 12:27:10 volumio sudo[23424]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 78 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 80 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 26 12:27:10 volumio volumio[1379]: info: Setting Spotify Volume from Volumio: 80 Apr 26 12:27:10 volumio volumio[1379]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 26 12:27:10 volumio sudo[23427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Apr 26 12:27:10 volumio sudo[23424]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio sudo[23427]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio sudo[23427]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio volumio[1379]: info: peppyspectrum Daemon Started Apr 26 12:27:10 volumio volumio[1379]: info: peppymeterbasic Daemon Started Apr 26 12:27:10 volumio volumio[1379]: info: VolumeController::SetAlsaVolume48 Apr 26 12:27:10 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:27:10 volumio volumio[1379]: info: [ASDebug] CurState: play PrevState: play Apr 26 12:27:10 volumio volumio[1379]: info: [GPIO_Control] Status changed: play Apr 26 12:27:10 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 26 12:27:10 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status play Apr 26 12:27:10 volumio sudo[23564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 26 12:27:10 volumio sudo[23564]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio sudo[23564]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 80 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 48 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 26 12:27:10 volumio volumio[1379]: info: Setting Spotify Volume from Volumio: 48 Apr 26 12:27:10 volumio sudo[23567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Apr 26 12:27:10 volumio sudo[23567]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio volumio[1379]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 26 12:27:10 volumio volumio[1379]: info: peppymeterbasic Daemon Started Apr 26 12:27:10 volumio sudo[23567]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio volumio[1379]: info: peppyspectrum Daemon Started Apr 26 12:27:10 volumio volumio[1379]: info: VolumeController::SetAlsaVolume47 Apr 26 12:27:10 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 12:27:10 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:27:10 volumio volumio[1379]: info: [ASDebug] CurState: play PrevState: play Apr 26 12:27:10 volumio volumio[1379]: info: [GPIO_Control] Status changed: play Apr 26 12:27:10 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status play Apr 26 12:27:10 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status play Apr 26 12:27:10 volumio sudo[23592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Apr 26 12:27:10 volumio sudo[23592]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:27:10 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:27:10 volumio volumio[1379]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 26 12:27:10 volumio sudo[23595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Apr 26 12:27:10 volumio sudo[23595]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:27:10 volumio sudo[23592]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio sudo[23595]: pam_unix(sudo:session): session closed for user root Apr 26 12:27:10 volumio volumio[1379]: info: peppymeterbasic Daemon Started Apr 26 12:27:10 volumio volumio[1379]: info: peppyspectrum Daemon Started Apr 26 12:27:12 volumio volumio[1379]: SPOTIFY: SETTING SPOTIFY VOLUME 48 Apr 26 12:27:12 volumio volumio[1379]: info: Sending Spotify command with payload to local API: /player/volume Apr 26 12:27:12 volumio volumio[1379]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 12:27:12 volumio volumio[1379]: info: FusionDsp - no preset used Apr 26 12:27:12 volumio volumio[1379]: info: FusionDsp - kef.json,test.json Apr 26 12:27:16 volumio volumio[32448]: libpng warning: iCCP: known incorrect sRGB profile Apr 26 12:27:16 volumio volumio[32448]: libpng warning: iCCP: known incorrect sRGB profile Apr 26 12:27:37 volumio volumio[32448]: libpng warning: iCCP: known incorrect sRGB profile Apr 26 12:27:37 volumio volumio[1379]: info: CALLMETHOD: audio_interface fusiondsp choosedsp [object Object] Apr 26 12:27:37 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , choosedsp Apr 26 12:27:37 volumio volumio[1379]: error: FusionDsp - File size not found in array! Apr 26 12:27:37 volumio volumio[1379]: info: FusionDsp - Nulleq applied Apr 26 12:27:37 volumio volumio[1379]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 12:27:37 volumio volumio[1379]: info: CoreCommandRouter::Close All Modals sent Apr 26 12:27:37 volumio volumio[1379]: info: FusionDsp - no preset used Apr 26 12:27:37 volumio volumio[1379]: info: FusionDsp - kef.json,test.json Apr 26 12:27:38 volumio volumio[1379]: info: CALLMETHOD: audio_interface fusiondsp choosedsp [object Object] Apr 26 12:27:38 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , choosedsp Apr 26 12:27:38 volumio volumio[1379]: error: FusionDsp - File size not found in array! Apr 26 12:27:38 volumio volumio[1379]: info: FusionDsp - Nulleq applied Apr 26 12:27:38 volumio volumio[1379]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 26 12:27:38 volumio volumio[1379]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 12:27:38 volumio volumio[1379]: info: CoreCommandRouter::Close All Modals sent Apr 26 12:27:38 volumio volumio[1379]: info: FusionDsp - no preset used Apr 26 12:27:38 volumio volumio[1379]: info: FusionDsp - kef.json,test.json Apr 26 12:27:57 volumio volumio[32448]: libpng warning: iCCP: known incorrect sRGB profile Apr 26 12:27:57 volumio volumio[32448]: libpng warning: iCCP: known incorrect sRGB profile Apr 26 12:28:01 volumio volumio[1379]: info: CoreCommandRouter::volumioGetState Apr 26 12:28:03 volumio volumio[1379]: info: Executing endpoint metavolumio Apr 26 12:28:03 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 26 12:28:03 volumio volumio[1379]: info: Executing endpoint metavolumio Apr 26 12:28:03 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 26 12:28:08 volumio volumio[1379]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 12:28:08 volumio volumio[1379]: info: FusionDsp - no preset used Apr 26 12:28:08 volumio volumio[1379]: info: FusionDsp - kef.json,test.json Apr 26 12:28:15 volumio volumio[1379]: info: CoreCommandRouter::volumioGetState Apr 26 12:28:17 volumio volumio[1379]: info: Executing endpoint metavolumio Apr 26 12:28:17 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 26 12:28:17 volumio volumio[1379]: info: Executing endpoint metavolumio Apr 26 12:28:17 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 26 12:28:18 volumio volumio[1379]: error: Failed request for metavolumio API Apr 26 12:28:27 volumio volumio[1379]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 12:28:27 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 26 12:28:27 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:27 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 26 12:28:27 volumio volumio[1379]: info: Getting Alsa Cards List without I2S DAC Apr 26 12:28:28 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 26 12:28:28 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:28 volumio volumio[1379]: Invalid card number. Apr 26 12:28:28 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 12:28:28 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 12:28:28 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 12:28:28 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 26 12:28:28 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 26 12:28:37 volumio volumio[32448]: libpng warning: iCCP: known incorrect sRGB profile Apr 26 12:28:37 volumio volumio[32448]: libpng warning: iCCP: known incorrect sRGB profile Apr 26 12:28:37 volumio volumio[32448]: libpng warning: iCCP: known incorrect sRGB profile Apr 26 12:28:53 volumio volumio[1379]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 26 12:28:53 volumio volumio[1379]: info: Preparing to save Alsa Options, stopping services first Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::volumioGetState Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::volumioStop Apr 26 12:28:53 volumio volumio[1379]: info: CoreStateMachine::stop Apr 26 12:28:53 volumio volumio[1379]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 26 12:28:53 volumio volumio[1379]: info: CoreStateMachine::stPlaybackTimer Apr 26 12:28:53 volumio volumio[1379]: info: CoreStateMachine::updateTrackBlock Apr 26 12:28:53 volumio volumio[1379]: info: CorePlayQueue::getTrackBlock Apr 26 12:28:53 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:53 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:53 volumio volumio[1379]: info: CoreStateMachine::serviceStop Apr 26 12:28:53 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::serviceStop Apr 26 12:28:53 volumio volumio[1379]: info: ControllerMpd::stop Apr 26 12:28:53 volumio volumio[1379]: verbose: ControllerMpd::sendMpdCommand stop Apr 26 12:28:53 volumio volumio[1379]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"HDMI 0 Out"},"i2s":true,"i2sid":{"value":"rpi-dacplus","label":"Raspberry Pi DAC+"}} Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:53 volumio volumio[1379]: info: Enabling I2S DAC: Raspberry Pi DAC+ Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:53 volumio sudo[20737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Apr 26 12:28:53 volumio sudo[20737]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:53 volumio sudo[20737]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:53 volumio volumio[1379]: info: No Overlays Loaded Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Apr 26 12:28:53 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:53 volumio sudo[20740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rpi-dacplus Apr 26 12:28:53 volumio sudo[20740]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2s@a0000/status Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/status Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/#sound-dai-cells Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/compatible Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/reg Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/AVDD-supply Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/DVDD-supply Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/CPVDD-supply Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/status Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/card_name Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/dai_name Apr 26 12:28:53 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/dai_stream_name Apr 26 12:28:53 volumio sudo[20740]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: warn: Unable to locate the device HDMI 0 Out a reboot may be required. Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:54 volumio volumio[1379]: info: Found match in i2s Card Database: setting mixer Digital for card Raspberry Pi DAC+ Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 26 12:28:54 volumio volumio[1379]: info: Updating Volume Controller Parameters: Device: 2 Name: softvolume Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 26 12:28:54 volumio volumio[1379]: info: Disabling external Volume Control Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 26 12:28:54 volumio volumio[1379]: info: Enable softmixer device for audio device undefined Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] CurState: stop PrevState: play Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Apr 26 12:28:54 volumio volumio[1379]: info: [GPIO_Control] Status changed: stop Apr 26 12:28:54 volumio volumio[1379]: info: [GPIO_Control] Handling event: musicStop Apr 26 12:28:54 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:54 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:54 volumio sudo[20756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:54 volumio sudo[20756]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio systemd[1]: Stopping peppymeterbasic Daemon... Apr 26 12:28:54 volumio systemd[1]: peppymeterbasic.service: Main process exited, code=killed, status=15/TERM Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:54 volumio sudo[20759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:54 volumio sudo[20759]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio systemd[1]: Stopping peppyspectrum Daemon... Apr 26 12:28:54 volumio systemd[1]: peppyspectrum.service: Main process exited, code=killed, status=15/TERM Apr 26 12:28:54 volumio systemd[1]: peppymeterbasic.service: Succeeded. Apr 26 12:28:54 volumio systemd[1]: Stopped peppymeterbasic Daemon. Apr 26 12:28:54 volumio volumio[1379]: info: Apr 26 12:28:54 volumio volumio[1379]: ---------------------------- MPD announces state update: player Apr 26 12:28:54 volumio volumio[1379]: info: sendMpdCommand stop took 267 milliseconds Apr 26 12:28:54 volumio volumio[1379]: info: ControllerMpd::getState Apr 26 12:28:54 volumio volumio[1379]: verbose: ControllerMpd::sendMpdCommand status Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::servicePushState Apr 26 12:28:54 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:54 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:54 volumio sudo[20756]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:54 volumio volumio[1379]: verbose: STATE SERVICE {"status":"stop"} Apr 26 12:28:54 volumio volumio[1379]: verbose: CURRENT POSITION 0 Apr 26 12:28:54 volumio volumio[1379]: info: CoreStateMachine::syncState stateService stop Apr 26 12:28:54 volumio volumio[1379]: info: CoreStateMachine::syncState currentStatus stop Apr 26 12:28:54 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:54 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:54 volumio volumio[1379]: info: No code Apr 26 12:28:54 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:54 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:54 volumio systemd[1]: peppyspectrum.service: Succeeded. Apr 26 12:28:54 volumio systemd[1]: Stopped peppyspectrum Daemon. Apr 26 12:28:54 volumio sudo[20759]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 26 12:28:54 volumio volumio[1379]: info: I2S Param [object Object] successfully enabled Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] CurState: stop PrevState: play Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] CurState: stop PrevState: play Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] CurState: stop PrevState: play Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Apr 26 12:28:54 volumio volumio[1379]: info: [GPIO_Control] Status changed: stop Apr 26 12:28:54 volumio volumio[1379]: info: [GPIO_Control] Status changed: stop Apr 26 12:28:54 volumio volumio[1379]: info: [GPIO_Control] Status changed: stop Apr 26 12:28:54 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:54 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:54 volumio sudo[20765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:54 volumio sudo[20765]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:54 volumio sudo[20768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:54 volumio sudo[20768]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio sudo[20765]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:54 volumio sudo[20771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:54 volumio sudo[20771]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio sudo[20768]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:54 volumio sudo[20774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:54 volumio sudo[20774]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio sudo[20771]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:54 volumio sudo[20774]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio sudo[20777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:54 volumio sudo[20777]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio sudo[20780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:54 volumio sudo[20780]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:54 volumio sudo[20777]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: info: sendMpdCommand status took 256 milliseconds Apr 26 12:28:54 volumio volumio[1379]: verbose: ControllerMpd::parseState Apr 26 12:28:54 volumio volumio[1379]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 26 12:28:54 volumio sudo[20780]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:54 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:54 volumio volumio[1379]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 26 12:28:54 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: peppymeterbasic Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: Software Volume ALSA configuration written Apr 26 12:28:54 volumio volumio[1379]: info: Preparing to generate the ALSA configuration file Apr 26 12:28:54 volumio volumio[1379]: info: sendMpdCommand playlistinfo took 56 milliseconds Apr 26 12:28:54 volumio volumio[1379]: verbose: ControllerMpd::parseTrackInfo Apr 26 12:28:54 volumio volumio[1379]: info: ControllerMpd::pushState Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::servicePushState Apr 26 12:28:54 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:54 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:54 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:54 volumio volumio[1379]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Apr 26 12:28:54 volumio volumio[1379]: info: ------------------------------ 337ms Apr 26 12:28:54 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: peppymeterbasic Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: peppymeterbasic Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: VolumeController:: Volume=undefined Mute =false Apr 26 12:28:54 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:54 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:54 volumio volumio[1379]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 26 12:28:54 volumio volumio[1379]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 26 12:28:54 volumio volumio[1379]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Apr 26 12:28:54 volumio volumio[1379]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Apr 26 12:28:54 volumio volumio[1379]: info: Reading ALSA contributions from plugins. Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 26 12:28:54 volumio volumio[1379]: info: Getting Alsa Cards List without I2S DAC Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:54 volumio volumio[1379]: Invalid card number. Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] CurState: stop PrevState: play Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] CurState: stop PrevState: play Apr 26 12:28:54 volumio volumio[1379]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Apr 26 12:28:54 volumio volumio[1379]: info: [GPIO_Control] Status changed: stop Apr 26 12:28:54 volumio volumio[1379]: info: [GPIO_Control] Status changed: stop Apr 26 12:28:54 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:54 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:54 volumio sudo[20798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:54 volumio sudo[20798]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:54 volumio sudo[20800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:54 volumio sudo[20800]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:54 volumio sudo[20804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:54 volumio sudo[20804]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio sudo[20798]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:54 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:54 volumio sudo[20800]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio sudo[20807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:54 volumio sudo[20807]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio sudo[20804]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: info: peppymeterbasic Daemon Stop Apr 26 12:28:54 volumio sudo[20807]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: peppymeterbasic Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:54 volumio volumio[1379]: info: Asound.conf file written Apr 26 12:28:54 volumio sudo[20817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 26 12:28:54 volumio sudo[20817]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio sudo[20817]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: info: Output device has changed, restarting MPD Apr 26 12:28:54 volumio sudo[20822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 26 12:28:54 volumio sudo[20822]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio sudo[20822]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:54 volumio volumio[1379]: info: Output device has changed, restarting Shairport Sync Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:54 volumio sudo[20825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 26 12:28:54 volumio sudo[20825]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:54 volumio systemd[1]: musicservicesshield.service: Succeeded. Apr 26 12:28:54 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 26 12:28:54 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 26 12:28:54 volumio systemd[1]: Stopping Music Player Daemon... Apr 26 12:28:54 volumio systemd[1]: mpd.service: Succeeded. Apr 26 12:28:54 volumio systemd[1]: Stopped Music Player Daemon. Apr 26 12:28:54 volumio volumio[1379]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 26 12:28:54 volumio volumio[1379]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 26 12:28:54 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:54 volumio vtcs[6066]: [2025-04-26 12:28:54.959] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Apr 26 12:28:54 volumio vtcs[6066]: [2025-04-26 12:28:54.960] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Apr 26 12:28:54 volumio systemd[1]: Starting Music Player Daemon... Apr 26 12:28:54 volumio volumio[1379]: info: Output device has changed, restarting MPD Apr 26 12:28:54 volumio sudo[20834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 26 12:28:54 volumio sudo[20834]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio sudo[20837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 26 12:28:55 volumio sudo[20837]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 26 12:28:55 volumio sudo[20830]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 26 12:28:55 volumio sudo[20830]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 26 12:28:55 volumio sudo[20837]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio systemd[1]: vtcs.service: Succeeded. Apr 26 12:28:55 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 26 12:28:55 volumio sudo[20834]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio sudo[20830]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio volumio[1379]: info: Output device has changed, restarting Shairport Sync Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:55 volumio sudo[20841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 26 12:28:55 volumio sudo[20841]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio volumio[1379]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 26 12:28:55 volumio volumio[1379]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 26 12:28:55 volumio systemd[1]: mpd.service: Succeeded. Apr 26 12:28:55 volumio systemd[1]: Stopped Music Player Daemon. Apr 26 12:28:55 volumio systemd[1]: Starting Music Player Daemon... Apr 26 12:28:55 volumio sudo[20852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 26 12:28:55 volumio sudo[20852]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio sudo[20849]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 26 12:28:55 volumio sudo[20849]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio sudo[20849]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio sudo[20856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 26 12:28:55 volumio sudo[20856]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio sudo[20860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 26 12:28:55 volumio sudo[20860]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio sudo[20852]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio sudo[20860]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:55 volumio sudo[20856]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio volumio[1379]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Apr 26 12:28:55 volumio volumio[1379]: info: MPD Permissions set Apr 26 12:28:55 volumio volumio[1379]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Apr 26 12:28:55 volumio volumio[1379]: info: MPD Permissions set Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 12:28:55 volumio volumio[1379]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::volumioGetState Apr 26 12:28:55 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::volumioPause Apr 26 12:28:55 volumio volumio[1379]: info: CoreStateMachine::pause Apr 26 12:28:55 volumio volumio[1379]: info: mpdhttpout --- Volumio set on pause Apr 26 12:28:55 volumio volumio[1379]: info: Starting Shairport Sync Apr 26 12:28:55 volumio volumio[1379]: info: Starting Shairport Sync Apr 26 12:28:55 volumio sudo[20888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 26 12:28:55 volumio sudo[20888]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio volumio[1379]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::volumioGetState Apr 26 12:28:55 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:55 volumio volumio[1379]: info: CoreCommandRouter::volumioPause Apr 26 12:28:55 volumio volumio[1379]: info: CoreStateMachine::pause Apr 26 12:28:55 volumio volumio[1379]: info: mpdhttpout --- Volumio set on pause Apr 26 12:28:55 volumio sudo[20891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 26 12:28:55 volumio sudo[20891]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:55 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 26 12:28:55 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 26 12:28:55 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:55 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 26 12:28:55 volumio sudo[20891]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio sudo[20888]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio volumio[1379]: info: Shairport-Sync Started Apr 26 12:28:55 volumio volumio[1379]: info: Shairport-Sync Started Apr 26 12:28:55 volumio volumio[1379]: info: [ASDebug] Togle GPIO: OFF Apr 26 12:28:55 volumio mpd[20857]: Apr 26 12:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 26 12:28:55 volumio systemd[1]: Started Music Player Daemon. Apr 26 12:28:55 volumio sudo[20841]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio sudo[20825]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:55 volumio volumio[1379]: error: MPD error: The expression evaluated to a falsy value: Apr 26 12:28:55 volumio volumio[1379]: assert.ok(self.idling) Apr 26 12:28:55 volumio volumio[1379]: error: The expression evaluated to a falsy value: Apr 26 12:28:55 volumio volumio[1379]: assert.ok(self.idling) Apr 26 12:28:55 volumio volumio[1379]: error: updateQueue error: null Apr 26 12:28:55 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 26 12:28:55 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:55 volumio volumio[20947]: cset: --> shielding system active with Apr 26 12:28:55 volumio volumio[20947]: cset: "system" cpuset of CPUSPEC(1-3) with 296 tasks running Apr 26 12:28:55 volumio volumio[20947]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Apr 26 12:28:55 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 26 12:28:57 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 26 12:28:57 volumio sudo[21550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 26 12:28:57 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 26 12:28:57 volumio sudo[21550]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:57 volumio systemd[1]: musicservicesshield.service: Succeeded. Apr 26 12:28:57 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 26 12:28:57 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 26 12:28:57 volumio systemd[1]: Stopping Music Player Daemon... Apr 26 12:28:57 volumio systemd[1]: mpd.service: Succeeded. Apr 26 12:28:57 volumio systemd[1]: Stopped Music Player Daemon. Apr 26 12:28:57 volumio sudo[21553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 26 12:28:57 volumio sudo[21553]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:57 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:57 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:57 volumio systemd[1]: Starting Music Player Daemon... Apr 26 12:28:57 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 26 12:28:57 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:57 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:57 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:57 volumio systemd[1]: mpd.service: Succeeded. Apr 26 12:28:57 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:57 volumio systemd[1]: Stopped Music Player Daemon. Apr 26 12:28:57 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 26 12:28:57 volumio systemd[1]: Starting Music Player Daemon... Apr 26 12:28:57 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:57 volumio sudo[21563]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 26 12:28:57 volumio sudo[21563]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:57 volumio sudo[21563]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:57 volumio mpd[21572]: Apr 26 12:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 26 12:28:57 volumio systemd[1]: Started Music Player Daemon. Apr 26 12:28:57 volumio sudo[21553]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:57 volumio sudo[21550]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:57 volumio volumio[1379]: error: MPD error: The expression evaluated to a falsy value: Apr 26 12:28:57 volumio volumio[1379]: assert.ok(self.idling) Apr 26 12:28:57 volumio volumio[1379]: error: The expression evaluated to a falsy value: Apr 26 12:28:57 volumio volumio[1379]: assert.ok(self.idling) Apr 26 12:28:57 volumio volumio[1379]: error: updateQueue error: null Apr 26 12:28:57 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Apr 26 12:28:57 volumio volumio[1379]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 26 12:28:57 volumio volumio[21661]: cset: --> shielding system active with Apr 26 12:28:57 volumio volumio[21661]: cset: "system" cpuset of CPUSPEC(1-3) with 290 tasks running Apr 26 12:28:57 volumio volumio[21661]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Apr 26 12:28:57 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Apr 26 12:28:58 volumio volumio[1379]: info: TidalConnect service stoped! Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 26 12:28:58 volumio volumio[1379]: info: CoreStateMachine::getcurrentVolume Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::volumioRetrievevolume Apr 26 12:28:58 volumio volumio[1379]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 26 12:28:58 volumio volumio[1379]: info: VolumeController:: Volume=undefined Mute =false Apr 26 12:28:58 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:58 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:58 volumio volumio[1379]: info: CoreStateMachine::updateTrackBlock Apr 26 12:28:58 volumio volumio[1379]: info: CorePlayQueue::getTrackBlock Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::volumioRetrievevolume Apr 26 12:28:58 volumio volumio[1379]: info: [ASDebug] CurState: stop PrevState: stop Apr 26 12:28:58 volumio volumio[1379]: info: [GPIO_Control] Status changed: stop Apr 26 12:28:58 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:58 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:58 volumio sudo[21765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:58 volumio sudo[21765]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:58 volumio volumio[1379]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 26 12:28:58 volumio sudo[21768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:58 volumio sudo[21768]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio sudo[21765]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio sudo[21768]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:58 volumio volumio[1379]: info: peppymeterbasic Daemon Stop Apr 26 12:28:58 volumio volumio[1379]: info: TidalConnect service stoped! Apr 26 12:28:58 volumio volumio[1379]: info: TidalConnect service stoped! Apr 26 12:28:58 volumio volumio[1379]: info: VolumeController:: Volume=undefined Mute =false Apr 26 12:28:58 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:58 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:58 volumio volumio[1379]: info: [ASDebug] CurState: stop PrevState: stop Apr 26 12:28:58 volumio volumio[1379]: info: [GPIO_Control] Status changed: stop Apr 26 12:28:58 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:58 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:58 volumio sudo[21795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:58 volumio sudo[21795]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio sudo[21798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:58 volumio sudo[21798]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio sudo[21795]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:58 volumio volumio[1379]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 26 12:28:58 volumio volumio[1379]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 26 12:28:58 volumio volumio[1379]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 26 12:28:58 volumio volumio[1379]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 26 12:28:58 volumio volumio[1379]: info: peppymeterbasic Daemon Stop Apr 26 12:28:58 volumio sudo[21798]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:58 volumio sudo[21808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 26 12:28:58 volumio sudo[21808]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio sudo[21811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 26 12:28:58 volumio sudo[21811]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 26 12:28:58 volumio sudo[21808]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio sudo[21811]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio volumio[1379]: info: Executing endpoint tc_getconfig Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 26 12:28:58 volumio vtcs[21813]: STARTING TidalConnect services, version: 1.5.0.45 Apr 26 12:28:58 volumio vtcs[21813]: STARTED TidalConnect services. Apr 26 12:28:58 volumio volumio[1379]: info: Executing endpoint tc_connect Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 26 12:28:58 volumio volumio[1379]: info: Connecting to TidalConnect Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::servicePushState Apr 26 12:28:58 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:58 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:58 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:58 volumio volumio[1379]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::servicePushState Apr 26 12:28:58 volumio volumio[1379]: info: CoreStateMachine::pushState Apr 26 12:28:58 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:58 volumio volumio[1379]: info: CoreCommandRouter::volumioPushState Apr 26 12:28:58 volumio volumio[1379]: info: CorePlayQueue::getTrack 0 Apr 26 12:28:58 volumio volumio[1379]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect Apr 26 12:28:58 volumio volumio[1379]: info: [ASDebug] CurState: stop PrevState: stop Apr 26 12:28:58 volumio volumio[1379]: info: [GPIO_Control] Status changed: stop Apr 26 12:28:58 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:58 volumio volumio[1379]: info: PeppyMeterBasic ---peppymeterbasic status stop Apr 26 12:28:58 volumio sudo[21869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:58 volumio sudo[21869]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:58 volumio sudo[21872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Apr 26 12:28:58 volumio sudo[21872]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio volumio[1379]: info: PeppySpectrum ---peppyspectrum status stop Apr 26 12:28:58 volumio sudo[21869]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio sudo[21875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:58 volumio sudo[21875]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: SPOTIFY VOLUME 48 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: VOLUMIO VOLUME 47 Apr 26 12:28:58 volumio volumio[1379]: SPOTIFY: DELTA VOLUME ENOUGH: false Apr 26 12:28:58 volumio sudo[21878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Apr 26 12:28:58 volumio sudo[21878]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 12:28:58 volumio volumio[1379]: info: peppymeterbasic Daemon Stop Apr 26 12:28:58 volumio sudo[21872]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio sudo[21875]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:58 volumio volumio[1379]: info: peppymeterbasic Daemon Stop Apr 26 12:28:58 volumio sudo[21878]: pam_unix(sudo:session): session closed for user root Apr 26 12:28:58 volumio volumio[1379]: info: peppyspectrum Daemon Stop Apr 26 12:28:59 volumio volumio[1379]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Apr 26 12:28:59 volumio volumio[1379]: info: PLUGIN onReboot : networkfs Apr 26 12:28:59 volumio volumio[1379]: info: PLUGIN onReboot : audiophonicsonoff Apr 26 12:28:59 volumio volumio[1379]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 12:28:59 volumio volumio[1379]: TypeError: Cannot read property 'writeSync' of undefined Apr 26 12:28:59 volumio volumio[1379]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_hardware/audiophonicsonoff/index.js:40:25) Apr 26 12:28:59 volumio volumio[1379]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Apr 26 12:28:59 volumio volumio[1379]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Apr 26 12:28:59 volumio volumio[1379]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Apr 26 12:28:59 volumio volumio[1379]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Apr 26 12:28:59 volumio volumio[1379]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Apr 26 12:28:59 volumio volumio[1379]: at CoreCommandRouter.reboot (/volumio/app/index.js:1350:22) Apr 26 12:28:59 volumio volumio[1379]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:870:33) Apr 26 12:28:59 volumio volumio[1379]: at Socket.emit (events.js:315:20) Apr 26 12:28:59 volumio volumio[1379]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Apr 26 12:28:59 volumio volumio[1379]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 26 12:28:59 volumio volumio[1379]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 12:28:59 volumio sudo[22036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-26 12:27 Apr 26 12:28:59 volumio sudo[22036]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"