-- Logs begin at Tue 2020-12-22 13:39:53 UTC, end at Fri 2025-07-11 10:45:30 UTC. -- Jul 11 10:45:13 volumio systemd[1]: Time has been changed Jul 11 10:45:14 volumio volumio[824]: info: Loading plugin "networkfs"... Jul 11 10:45:14 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 11 10:45:14 volumio volumio[824]: info: Loading plugin "alarm-clock"... Jul 11 10:45:14 volumio sudo[1090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //WDMYCLOUD/Public /mnt/NAS/Public Jul 11 10:45:14 volumio sudo[1090]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:15 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching Jul 11 10:45:15 volumio kernel: Key type cifs.spnego registered Jul 11 10:45:15 volumio kernel: Key type cifs.idmap registered Jul 11 10:45:15 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Jul 11 10:45:15 volumio volumio[824]: info: Loading plugin "airplay_emulation"... Jul 11 10:45:15 volumio volumio[824]: info: Starting Shairport Sync Jul 11 10:45:15 volumio volumio[824]: info: Loading plugin "last_100"... Jul 11 10:45:15 volumio volumio[824]: info: Loading plugin "webradio"... Jul 11 10:45:15 volumio volumio[824]: info: Loading plugin "i2s_dacs"... Jul 11 10:45:15 volumio volumio[824]: info: I2S DAC not set, start Auto-detection Jul 11 10:45:15 volumio volumio[824]: info: Loading plugin "volumiodiscovery"... Jul 11 10:45:15 volumio volumio[824]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 11 10:45:15 volumio node[824]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 11 10:45:15 volumio node[824]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 11 10:45:15 volumio node[824]: *** WARNING *** For more information see Jul 11 10:45:15 volumio node[824]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 11 10:45:15 volumio node[824]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 11 10:45:15 volumio node[824]: *** WARNING *** For more information see Jul 11 10:45:15 volumio volumio[824]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 11 10:45:15 volumio volumio[824]: *** WARNING *** For more information see Jul 11 10:45:15 volumio volumio[824]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 11 10:45:15 volumio volumio[824]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 11 10:45:15 volumio volumio[824]: *** WARNING *** For more information see Jul 11 10:45:15 volumio volumio[824]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 11 10:45:15 volumio volumio[824]: Discovery: StartAdv! undefined Jul 11 10:45:15 volumio volumio[824]: Discovery: Started advertising... Volumio - undefined Jul 11 10:45:15 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 11 10:45:15 volumio volumio[824]: info: Loading plugin "auto_play"... Jul 11 10:45:15 volumio volumio[824]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Jul 11 10:45:15 volumio volumio[824]: info: Loading plugin "autostart"... Jul 11 10:45:16 volumio volumio[824]: info: Applying required configuration parameters for plugin autostart Jul 11 10:45:16 volumio volumio[824]: info: Loading plugin "outputs"... Jul 11 10:45:16 volumio volumio[824]: info: Loading plugin "albumart"... Jul 11 10:45:16 volumio volumio[824]: info: Plugin example_plugin is not enabled Jul 11 10:45:16 volumio volumio[824]: info: Loading plugin "inputs"... Jul 11 10:45:16 volumio volumio[824]: info: Loading plugin "updater_comm"... Jul 11 10:45:16 volumio volumio[824]: info: Plugin mpdemulation is not enabled Jul 11 10:45:16 volumio volumio[824]: info: Loading plugin "rest_api"... Jul 11 10:45:16 volumio volumio[824]: info: Loading plugin "websocket"... Jul 11 10:45:16 volumio volumio[824]: info: Loading plugin "allo_relay_volume_attenuator"... Jul 11 10:45:16 volumio volumio[824]: Forking 3 albumart workers Jul 11 10:45:17 volumio volumio[824]: Starting albumart workers Jul 11 10:45:17 volumio volumio[824]: Starting albumart workers Jul 11 10:45:17 volumio volumio[824]: Starting albumart workers Jul 11 10:45:18 volumio volumio[824]: info: Applying required configuration parameters for plugin allo_relay_volume_attenuator Jul 11 10:45:18 volumio volumio[824]: info: Loading plugin "RoonBridge"... Jul 11 10:45:18 volumio volumio[824]: info: Applying required configuration parameters for plugin RoonBridge Jul 11 10:45:18 volumio volumio[824]: info: Loading plugin "audiophonicsonoff"... Jul 11 10:45:19 volumio volumio[824]: info: Audiophonics on/off initiated Jul 11 10:45:19 volumio volumio[824]: info: Loading plugin "backup_restore"... Jul 11 10:45:19 volumio volumio[824]: info: ___________ START PLUGINS ___________ Jul 11 10:45:19 volumio volumio[824]: info: [GPIO_Control] Reading config and creating GPIOs Jul 11 10:45:19 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 10:45:19 volumio volumio[824]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 11 10:45:19 volumio volumio[824]: info: [1752230719779] CoreMusicLibrary::Adding element Media Servers Jul 11 10:45:19 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 10:45:19 volumio volumio[824]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 11 10:45:19 volumio volumio[824]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 11 10:45:19 volumio volumio[824]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 11 10:45:19 volumio volumio[824]: info: [1752230719895] CoreMusicLibrary::Adding element Last_100 Jul 11 10:45:19 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 10:45:19 volumio volumio[824]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 11 10:45:19 volumio volumio[824]: info: [1752230719899] CoreMusicLibrary::Adding element Webradio Jul 11 10:45:19 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 10:45:19 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 11 10:45:19 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 10:45:19 volumio volumio[824]: info: Configuring GPIO pins Jul 11 10:45:19 volumio sudo[1188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay lirc-rpi gpio_in_pin=17 Jul 11 10:45:19 volumio sudo[1188]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:19 volumio sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jul 11 10:45:19 volumio volumio[824]: info: Soft shutdown GPIO binding... OK Jul 11 10:45:19 volumio sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:19 volumio volumio[824]: info: Hardware button GPIO binding... OK Jul 11 10:45:19 volumio systemd[1]: Starting RoonBridge... Jul 11 10:45:19 volumio systemd[1]: Started RoonBridge. Jul 11 10:45:19 volumio volumio[824]: info: Boot OK GPIO binding... OK Jul 11 10:45:19 volumio sudo[1190]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:20 volumio volumio[824]: info: ------------------------------------------- Jul 11 10:45:20 volumio volumio[824]: info: ----- MyVolumio plugins startup ---- Jul 11 10:45:20 volumio volumio[824]: info: ------------------------------------------- Jul 11 10:45:20 volumio volumio[824]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 11 10:45:20 volumio volumio[824]: info: Loading i18n strings for locale it Jul 11 10:45:20 volumio volumio[824]: Updating browse sources language Jul 11 10:45:20 volumio volumio[824]: Cannot find translation for sourceMedia Servers Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 10:45:20 volumio sudo[1188]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::initPlayerControls Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 10:45:20 volumio volumio[824]: info: BOOT COMPLETED Jul 11 10:45:20 volumio volumio[824]: [Metrics] CommandRouter: 16s 312.95ms Jul 11 10:45:20 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 10:45:20 volumio sudo[1090]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:23 volumio RoonBridge[1218]: 00:00:00.012 Warn: get lock file path: /tmp/.rnbgem0- Jul 11 10:45:23 volumio RoonBridge[1218]: 00:00:00.354 Trace: [childprocess] using unix child process Jul 11 10:45:23 volumio RoonBridge[1218]: Initializing Jul 11 10:45:23 volumio RoonBridge[1218]: 00:00:00.616 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Jul 11 10:45:23 volumio RoonBridge[1218]: 00:00:00.660 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Jul 11 10:45:24 volumio RoonBridge[1218]: Not Running (.o) Jul 11 10:45:24 volumio volumio-remote-updater[603]: [2025-07-11 10:45:24] [connect] Successful connection Jul 11 10:45:24 volumio RoonBridge[1218]: Running Jul 11 10:45:24 volumio RoonBridge[1218]: 00:00:00.027 Warn: get lock file path: /tmp/.rnbhgem0- Jul 11 10:45:25 volumio volumio[824]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jul 11 10:45:25 volumio volumio[824]: info: CoreCommandRouter::Close All Modals sent Jul 11 10:45:25 volumio volumio[824]: info: CoreCommandRouter::Close All Modals sent Jul 11 10:45:25 volumio volumio[824]: Express server listening on port 3000 Jul 11 10:45:25 volumio volumio[824]: [Metrics] WebUI: 23s 56.05ms Jul 11 10:45:25 volumio volumio[824]: Volumio Calling Home Jul 11 10:45:25 volumio volumio[824]: info: [GPIO_Control] GPIOs created Jul 11 10:45:25 volumio volumio[824]: info: CoreStateMachine::resetVolumioState Jul 11 10:45:25 volumio volumio[824]: info: CoreStateMachine::getcurrentVolume Jul 11 10:45:25 volumio volumio[824]: info: CoreCommandRouter::volumioRetrievevolume Jul 11 10:45:25 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 10:45:25 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 10:45:25 volumio sudo[1307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start rattenu.service Jul 11 10:45:25 volumio sudo[1307]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:25 volumio sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 11 10:45:25 volumio sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:25 volumio sudo[1309]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:25 volumio systemd[1]: Starting Allo Relay attenuator Service... Jul 11 10:45:25 volumio systemd[1]: Started Allo Relay attenuator Service. Jul 11 10:45:25 volumio sudo[1307]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:26 volumio rattenu[1321]: Cannot retrive Volume Jul 11 10:45:26 volumio sudo[1315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 11 10:45:26 volumio rattenu[1321]: Error: Writing on I2C Jul 11 10:45:26 volumio sudo[1315]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:26 volumio sudo[1315]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:26 volumio volumio[824]: info: Setting Device type: Raspberry PI Jul 11 10:45:26 volumio volumio[824]: info: Error enabling lirc-rpi overlay: Error: Command failed: /usr/bin/sudo /usr/bin/dtoverlay lirc-rpi gpio_in_pin=17 Jul 11 10:45:26 volumio volumio[824]: DTOVERLAY[error]: failed to open '/boot/overlays/lirc-rpi.dtbo' Jul 11 10:45:26 volumio volumio[824]: * Failed to read '/boot/overlays/lirc-rpi.dtbo' Jul 11 10:45:26 volumio volumio[824]: info: MPD running with PID675 Jul 11 10:45:26 volumio volumio[824]: ,establishing connection Jul 11 10:45:26 volumio sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jul 11 10:45:26 volumio sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:26 volumio sudo[1340]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:26 volumio volumio-remote-updater[603]: [2025-07-11 10:45:26] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1752230724 101 Jul 11 10:45:26 volumio volumio[824]: info: VolumeController:: Volume=100 Mute =false Jul 11 10:45:26 volumio volumio[824]: info: CoreStateMachine::pushState Jul 11 10:45:26 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:26 volumio volumio[824]: info: CoreCommandRouter::volumioPushState Jul 11 10:45:26 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 10:45:26 volumio volumio[824]: info: CoreStateMachine::updateTrackBlock Jul 11 10:45:26 volumio volumio[824]: info: CorePlayQueue::getTrackBlock Jul 11 10:45:26 volumio volumio[824]: info: CoreCommandRouter::volumioRetrievevolume Jul 11 10:45:26 volumio volumio[824]: info: R Attenu started Jul 11 10:45:26 volumio volumio[824]: info: Adding Allo Relay attenuator parameters{"enabled":true,"setvolumescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/setvolume.sh","getvolumescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/getvolume.sh","setmutescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/setmute.sh","getmutescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/getmute.sh","minVol":0,"maxVol":63,"mapTo100":false} Jul 11 10:45:26 volumio volumio[824]: info: CoreCommandRouter::volumioUpdateVolumeScripts Jul 11 10:45:26 volumio volumio[824]: info: Updating Volume script: {"enabled":true,"setvolumescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/setvolume.sh","getvolumescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/getvolume.sh","setmutescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/setmute.sh","getmutescript":"/data/plugins/miscellanea/allo_relay_volume_attenuator/getmute.sh","minVol":0,"maxVol":63,"mapTo100":false} Jul 11 10:45:26 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 11 10:45:26 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 11 10:45:26 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 11 10:45:26 volumio volumio[824]: info: Jul 11 10:45:26 volumio volumio[824]: ---------------------------- Client requests Volume 95 Jul 11 10:45:26 volumio volumio[824]: info: VolumeController::SetAlsaVolume95 Jul 11 10:45:26 volumio volumio[824]: info: Volume script /bin/sh /data/plugins/miscellanea/allo_relay_volume_attenuator/setvolume.sh 63 Jul 11 10:45:26 volumio sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c SET_VOLUME=63 Jul 11 10:45:26 volumio sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:26 volumio rattenu[1321]: Error: Writing on I2C Jul 11 10:45:26 volumio sudo[1356]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:27 volumio sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c SET_MUTE=0 Jul 11 10:45:27 volumio sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:27 volumio rattenu[1321]: Error: Writing on I2C Jul 11 10:45:27 volumio sudo[1371]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:27 volumio volumio[824]: [sudo] password for volumio: [sudo] password for volumio: info: External Volume: SUCCESS Jul 11 10:45:27 volumio volumio[824]: info: CoreStateMachine::pushState Jul 11 10:45:27 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::volumioPushState Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 10:45:27 volumio volumio[824]: info: CoreStateMachine::pushState Jul 11 10:45:27 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::volumioPushState Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 10:45:27 volumio sudo[1388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c GET_VOLUME Jul 11 10:45:27 volumio sudo[1388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:27 volumio sudo[1388]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:27 volumio volumio[824]: [sudo] password for volumio: info: External Volume: 63 Jul 11 10:45:27 volumio sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/r_attenuc -c GET_MUTE Jul 11 10:45:27 volumio sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:27 volumio sudo[1403]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:27 volumio volumio[824]: [sudo] password for volumio: info: External Volume: 0 Jul 11 10:45:27 volumio volumio[824]: info: VolumeController:: Volume=100 Mute =false Jul 11 10:45:27 volumio volumio[824]: info: CoreStateMachine::pushState Jul 11 10:45:27 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::volumioPushState Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 10:45:27 volumio volumio[824]: info: Reloading queue from file Jul 11 10:45:27 volumio volumio[824]: error: updateQueue error: null Jul 11 10:45:27 volumio volumio[824]: error: Failed LSINFO: Error: [50@0] {} No such directory Jul 11 10:45:27 volumio volumio[824]: info: Setting volume on startup at 95 Jul 11 10:45:27 volumio volumio[824]: info: CoreStateMachine::setRepeat null single undefined Jul 11 10:45:27 volumio volumio[824]: info: CoreStateMachine::pushState Jul 11 10:45:27 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::volumioPushState Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 10:45:27 volumio volumio[824]: info: CoreStateMachine::setRandom null Jul 11 10:45:27 volumio volumio[824]: info: CoreStateMachine::pushState Jul 11 10:45:27 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::volumioPushState Jul 11 10:45:27 volumio volumio[824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 10:45:27 volumio volumio[824]: info: Starting Shairport Sync Jul 11 10:45:28 volumio volumio[824]: info: Starting Shairport Sync Jul 11 10:45:28 volumio sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 11 10:45:28 volumio sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 11 10:45:28 volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:28 volumio sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:28 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 11 10:45:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 11 10:45:28 volumio sudo[1421]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 11 10:45:28 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 11 10:45:28 volumio sudo[1423]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 11 10:45:28 volumio volumio[824]: Discovery: adding f3c5d89f-6ccc-4fe3-840b-3f4a9bd8a551 Jul 11 10:45:28 volumio volumio[824]: info: mDNS: Found device Volumio Jul 11 10:45:28 volumio volumio[824]: info: CoreCommandRouter::volumioGetState Jul 11 10:45:28 volumio sudo[1442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 11 10:45:28 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:28 volumio sudo[1442]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 10:45:28 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Jul 11 10:45:28 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 11 10:45:28 volumio sudo[1442]: pam_unix(sudo:session): session closed for user root Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] CurState: stop PrevState: na Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] CurState: stop PrevState: na Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] CurState: stop PrevState: na Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] CurState: stop PrevState: na Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jul 11 10:45:28 volumio volumio[824]: info: Shairport-Sync Started Jul 11 10:45:28 volumio volumio[824]: Error adding Membership: Error: addMembership EINVAL Jul 11 10:45:28 volumio volumio[824]: info: Upmpdcli Daemon Started Jul 11 10:45:28 volumio volumio[824]: info: Shairport-Sync Started Jul 11 10:45:28 volumio volumio[824]: info: CoreCommandRouter::volumioGetState Jul 11 10:45:28 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:28 volumio volumio[824]: info: CoreCommandRouter::volumioGetState Jul 11 10:45:28 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:28 volumio volumio[824]: info: CoreCommandRouter::volumioGetState Jul 11 10:45:28 volumio volumio[824]: info: CorePlayQueue::getTrack 0 Jul 11 10:45:28 volumio volumio[824]: info: ControllerAutoPlay - mpd ready Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] CurState: stop PrevState: na Jul 11 10:45:28 volumio volumio[824]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jul 11 10:45:29 volumio volumio[824]: info: [ASDebug] Togle GPIO: OFF Jul 11 10:45:29 volumio volumio[824]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 10:45:29 volumio volumio[824]: { Error: EPERM: operation not permitted, write Jul 11 10:45:29 volumio volumio[824]: at Object.fs.writeSync (fs.js:735:20) Jul 11 10:45:29 volumio volumio[824]: at Gpio.writeSync (/data/plugins/miscellanea/ampswitch/node_modules/onoff/onoff.js:212:6) Jul 11 10:45:29 volumio volumio[824]: at AmpSwitchController.off (/data/plugins/miscellanea/ampswitch/index.js:209:23) Jul 11 10:45:29 volumio volumio[824]: at Timeout._onTimeout (/data/plugins/miscellanea/ampswitch/index.js:185:88) Jul 11 10:45:29 volumio volumio[824]: at ontimeout (timers.js:482:11) Jul 11 10:45:29 volumio volumio[824]: at tryOnTimeout (timers.js:317:5) Jul 11 10:45:29 volumio volumio[824]: at Timer.listOnTimeout (timers.js:277:5) errno: -1, code: 'EPERM', syscall: 'write' } Jul 11 10:45:29 volumio volumio[824]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 10:45:30 volumio sudo[1504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-11 10:44 Jul 11 10:45:30 volumio sudo[1504]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 14:39:52 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="097e28ee6263e31d0bf6b690a02dcab3"