-- Logs begin at Tue 2025-02-18 00:04:27 UTC, end at Tue 2025-02-18 00:06:18 UTC. -- Feb 18 00:06:01 volumio systemd[1]: Time has been changed Feb 18 00:06:01 volumio volumio[1285]: info: Loading plugin "wizard"... Feb 18 00:06:01 volumio volumio[1285]: info: Loading plugin "volumio_command_line_client"... Feb 18 00:06:01 volumio volumio[1285]: info: Loading plugin "upnp"... Feb 18 00:06:01 volumio volumio[1285]: info: [1739837161580] Starting Upmpd Daemon Feb 18 00:06:01 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 18 00:06:01 volumio volumio[1285]: info: Loading plugin "my_music"... Feb 18 00:06:01 volumio volumio[1285]: info: Loading plugin "mpd"... Feb 18 00:06:01 volumio zabbix_agentd[1005]: active check configuration update from [172.17.160.7:10051] is working again Feb 18 00:06:02 volumio sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 18 00:06:02 volumio volumio[1285]: info: Loading plugin "upnp_browser"... Feb 18 00:06:02 volumio sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 00:06:02 volumio sudo[1318]: pam_unix(sudo:session): session closed for user root Feb 18 00:06:02 volumio sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 18 00:06:02 volumio sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 00:06:02 volumio systemd[1]: Stopping Music Player Daemon... Feb 18 00:06:02 volumio systemd[1]: Starting Music Player Daemon... Feb 18 00:06:03 volumio volumio[1285]: info: Loading plugin "networkfs"... Feb 18 00:06:03 volumio systemd[1]: Started Music Player Daemon. Feb 18 00:06:03 volumio sudo[1321]: pam_unix(sudo:session): session closed for user root Feb 18 00:06:04 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 18 00:06:04 volumio volumio[1285]: info: Loading plugin "alarm-clock"... Feb 18 00:06:04 volumio CRON[1341]: pam_unix(cron:session): session opened for user root by (uid=0) Feb 18 00:06:04 volumio CRON[1345]: (root) CMD (/usr/bin/sudo -H /var/lib/script/test.sh >> /dev/null 2>&1) Feb 18 00:06:04 volumio sudo[1346]: root : TTY=unknown ; PWD=/root ; USER=root ; COMMAND=/var/lib/script/test.sh Feb 18 00:06:04 volumio sudo[1346]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 00:06:04 volumio dhcpcd[461]: timed out Feb 18 00:06:04 volumio dhcpcd[461]: exited Feb 18 00:06:04 volumio ifup[427]: dhcpcd[461]: timed out Feb 18 00:06:04 volumio ifup[427]: dhcpcd[461]: exited Feb 18 00:06:04 volumio ifup[427]: Failed to bring up eth0. Feb 18 00:06:04 volumio volumio[1285]: info: Loading plugin "airplay_emulation"... Feb 18 00:06:04 volumio volumio[1285]: info: Starting Shairport Sync Feb 18 00:06:04 volumio volumio[1285]: info: Loading plugin "last_100"... Feb 18 00:06:04 volumio volumio[1285]: info: Loading plugin "webradio"... Feb 18 00:06:04 volumio volumio[1285]: info: Loading plugin "i2s_dacs"... Feb 18 00:06:04 volumio volumio[1285]: info: I2S DAC not set, start Auto-detection Feb 18 00:06:04 volumio volumio[1285]: info: Loading plugin "volumiodiscovery"... Feb 18 00:06:05 volumio volumio[1285]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 18 00:06:05 volumio node[1285]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 18 00:06:05 volumio node[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 18 00:06:05 volumio node[1285]: *** WARNING *** For more information see Feb 18 00:06:05 volumio node[1285]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 18 00:06:05 volumio node[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 18 00:06:05 volumio node[1285]: *** WARNING *** For more information see Feb 18 00:06:05 volumio volumio[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 18 00:06:05 volumio volumio[1285]: *** WARNING *** For more information see Feb 18 00:06:05 volumio volumio[1285]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 18 00:06:05 volumio volumio[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 18 00:06:05 volumio volumio[1285]: *** WARNING *** For more information see Feb 18 00:06:05 volumio volumio[1285]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 18 00:06:05 volumio volumio[1285]: Discovery: StartAdv! undefined Feb 18 00:06:05 volumio volumio[1285]: Discovery: Started advertising... Volumio - undefined Feb 18 00:06:05 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 18 00:06:05 volumio volumio[1285]: info: Loading plugin "auto_play"... Feb 18 00:06:05 volumio volumio[1285]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Feb 18 00:06:05 volumio volumio[1285]: info: Loading plugin "outputs"... Feb 18 00:06:05 volumio volumio[1285]: info: Loading plugin "albumart"... Feb 18 00:06:05 volumio volumio[1285]: info: Plugin example_plugin is not enabled Feb 18 00:06:05 volumio volumio[1285]: info: Loading plugin "inputs"... Feb 18 00:06:05 volumio volumio[1285]: info: Loading plugin "updater_comm"... Feb 18 00:06:05 volumio volumio[1285]: info: Plugin mpdemulation is not enabled Feb 18 00:06:05 volumio volumio[1285]: info: Loading plugin "rest_api"... Feb 18 00:06:05 volumio volumio[1285]: info: Loading plugin "websocket"... Feb 18 00:06:05 volumio volumio[1285]: info: ___________ START PLUGINS ___________ Feb 18 00:06:05 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 00:06:05 volumio volumio[1285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 18 00:06:05 volumio volumio[1285]: info: [1739837165803] CoreMusicLibrary::Adding element Media Servers Feb 18 00:06:05 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 00:06:05 volumio volumio[1285]: Forking 3 albumart workers Feb 18 00:06:05 volumio volumio[1285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 18 00:06:06 volumio volumio[1285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 18 00:06:06 volumio volumio[1285]: info: [1739837166056] CoreMusicLibrary::Adding element Last_100 Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 18 00:06:06 volumio volumio[1285]: info: [1739837166062] CoreMusicLibrary::Adding element Webradio Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 00:06:06 volumio volumio[1285]: info: ------------------------------------------- Feb 18 00:06:06 volumio volumio[1285]: info: ----- MyVolumio plugins startup ---- Feb 18 00:06:06 volumio volumio[1285]: info: ------------------------------------------- Feb 18 00:06:06 volumio volumio[1285]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 18 00:06:06 volumio volumio[1285]: info: Loading i18n strings for locale ru Feb 18 00:06:06 volumio volumio[1285]: Updating browse sources language Feb 18 00:06:06 volumio volumio[1285]: Cannot find translation for sourceMedia Servers Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::initPlayerControls Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 18 00:06:06 volumio volumio[1285]: info: BOOT COMPLETED Feb 18 00:06:06 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 00:06:07 volumio volumio[1285]: Starting albumart workers Feb 18 00:06:07 volumio volumio[1285]: Starting albumart workers Feb 18 00:06:07 volumio volumio[1285]: Starting albumart workers Feb 18 00:06:07 volumio avahi-daemon[624]: Interface wlan0.IPv4 no longer relevant for mDNS. Feb 18 00:06:07 volumio dhcpcd[1273]: wlan0: carrier lost Feb 18 00:06:07 volumio avahi-daemon[624]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 10.0.4.5. Feb 18 00:06:07 volumio dhcpcd[1273]: wlan0: deleting host route to 10.0.4.5 via 127.0.0.1 Feb 18 00:06:07 volumio dhcpcd[1273]: wlan0: deleting route to 10.0.4.0/24 Feb 18 00:06:07 volumio dhcpcd[1273]: wlan0: deleting default route via 10.0.4.1 Feb 18 00:06:07 volumio avahi-daemon[624]: Withdrawing address record for 10.0.4.5 on wlan0. Feb 18 00:06:07 volumio wpa_supplicant[1150]: wlan0: CTRL-EVENT-DISCONNECTED bssid=e0:28:6d:de:6a:e8 reason=3 locally_generated=1 Feb 18 00:06:08 volumio systemd[1]: Stopping LSB: Start NTP daemon... Feb 18 00:06:08 volumio ntpd[955]: ntpd exiting on signal 15 Feb 18 00:06:08 volumio ntp[1514]: Stopping NTP server: ntpd. Feb 18 00:06:08 volumio systemd[1]: Starting LSB: Start NTP daemon... Feb 18 00:06:08 volumio ntpd[1532]: ntpd 4.2.6p5@1.2349-o Mon Jul 25 22:35:28 UTC 2016 (1) Feb 18 00:06:08 volumio ntpd[1533]: proto: precision = 1.094 usec Feb 18 00:06:08 volumio ntpd[1533]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Feb 18 00:06:08 volumio ntp[1525]: Starting NTP server: ntpd. Feb 18 00:06:08 volumio systemd[1]: Started LSB: Start NTP daemon. Feb 18 00:06:08 volumio ntpd[1533]: Listen and drop on 1 v6wildcard :: UDP 123 Feb 18 00:06:08 volumio ntpd[1533]: Listen normally on 2 lo 127.0.0.1 UDP 123 Feb 18 00:06:08 volumio ntpd[1533]: peers refreshed Feb 18 00:06:08 volumio ntpd[1533]: Listening on routing socket on fd #19 for interface updates Feb 18 00:06:08 volumio ntpd[1533]: Deferring DNS for 0.debian.pool.ntp.org 1 Feb 18 00:06:08 volumio ntpd[1533]: Deferring DNS for 1.debian.pool.ntp.org 1 Feb 18 00:06:08 volumio ntpd[1533]: Deferring DNS for 2.debian.pool.ntp.org 1 Feb 18 00:06:08 volumio ntpd[1533]: Deferring DNS for 3.debian.pool.ntp.org 1 Feb 18 00:06:08 volumio ntpd[1534]: signal_no_reset: signal 17 had flags 4000000 Feb 18 00:06:10 volumio ntpd_intres[1534]: host name not found: 0.debian.pool.ntp.org Feb 18 00:06:10 volumio ntpd_intres[1534]: host name not found: 1.debian.pool.ntp.org Feb 18 00:06:10 volumio ntpd_intres[1534]: host name not found: 2.debian.pool.ntp.org Feb 18 00:06:10 volumio ntpd_intres[1534]: host name not found: 3.debian.pool.ntp.org Feb 18 00:06:11 volumio volumio[1285]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Feb 18 00:06:11 volumio volumio[1285]: info: CoreCommandRouter::Close All Modals sent Feb 18 00:06:11 volumio volumio[1285]: info: CoreCommandRouter::Close All Modals sent Feb 18 00:06:11 volumio volumio[1285]: Express server listening on port 3000 Feb 18 00:06:11 volumio volumio[1285]: Volumio Calling Home Feb 18 00:06:11 volumio volumio[1285]: info: CoreStateMachine::resetVolumioState Feb 18 00:06:11 volumio volumio[1285]: info: CoreStateMachine::getcurrentVolume Feb 18 00:06:11 volumio volumio[1285]: info: CoreCommandRouter::volumioRetrievevolume Feb 18 00:06:12 volumio sudo[1543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 18 00:06:12 volumio sudo[1543]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 00:06:12 volumio sudo[1543]: pam_unix(sudo:session): session closed for user root Feb 18 00:06:12 volumio volumio[1285]: info: Setting Device type: Raspberry PI Feb 18 00:06:12 volumio sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Feb 18 00:06:12 volumio volumio[1285]: info: MPD Permissions set Feb 18 00:06:12 volumio sudo[1553]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 00:06:12 volumio sudo[1553]: pam_unix(sudo:session): session closed for user root Feb 18 00:06:12 volumio volumio[1285]: info: VolumeController:: Volume=55 Mute =false Feb 18 00:06:12 volumio volumio[1285]: info: CoreStateMachine::pushState Feb 18 00:06:12 volumio volumio[1285]: info: CoreStateMachine::getState Feb 18 00:06:12 volumio volumio[1285]: info: CorePlayQueue::getTrack 0 Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::volumioPushState Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 00:06:12 volumio volumio[1285]: info: CoreStateMachine::updateTrackBlock Feb 18 00:06:12 volumio volumio[1285]: info: CorePlayQueue::getTrackBlock Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::volumioRetrievevolume Feb 18 00:06:12 volumio volumio[1285]: info: MPD running with PID1333 ,establishing connection Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 00:06:12 volumio volumio[1285]: info: Reloading queue from file Feb 18 00:06:12 volumio volumio[1285]: info: Feb 18 00:06:12 volumio volumio[1285]: info: message= [50@0] {} No such directory, stack=Error: [50@0] {} No such directory Feb 18 00:06:12 volumio volumio[1285]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Feb 18 00:06:12 volumio volumio[1285]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Feb 18 00:06:12 volumio volumio[1285]: at emitOne (events.js:116:13) Feb 18 00:06:12 volumio volumio[1285]: at Socket.emit (events.js:211:7) Feb 18 00:06:12 volumio volumio[1285]: at addChunk (_stream_readable.js:263:12) Feb 18 00:06:12 volumio volumio[1285]: at readableAddChunk (_stream_readable.js:246:13) Feb 18 00:06:12 volumio volumio[1285]: at Socket.Readable.push (_stream_readable.js:208:10) Feb 18 00:06:12 volumio volumio[1285]: at Pipe.onread (net.js:607:20) Feb 18 00:06:12 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 18 00:06:13 volumio kernel: brcmfmac: power management disabled Feb 18 00:06:13 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 18 00:06:13 volumio volumio[1285]: info: CoreStateMachine::setRepeat null single undefined Feb 18 00:06:13 volumio volumio[1285]: info: CoreStateMachine::pushState Feb 18 00:06:13 volumio volumio[1285]: info: CoreStateMachine::getState Feb 18 00:06:13 volumio volumio[1285]: info: CorePlayQueue::getTrack 0 Feb 18 00:06:13 volumio volumio[1285]: info: CoreCommandRouter::volumioPushState Feb 18 00:06:13 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 00:06:13 volumio volumio[1285]: info: CoreStateMachine::setRandom null Feb 18 00:06:13 volumio volumio[1285]: info: CoreStateMachine::pushState Feb 18 00:06:13 volumio volumio[1285]: info: CoreStateMachine::getState Feb 18 00:06:13 volumio volumio[1285]: info: CorePlayQueue::getTrack 0 Feb 18 00:06:13 volumio volumio[1285]: info: CoreCommandRouter::volumioPushState Feb 18 00:06:13 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 00:06:13 volumio volumio[1285]: info: VolumeController:: Volume=55 Mute =false Feb 18 00:06:13 volumio volumio[1285]: info: CoreStateMachine::pushState Feb 18 00:06:13 volumio volumio[1285]: info: CoreStateMachine::getState Feb 18 00:06:13 volumio volumio[1285]: info: CorePlayQueue::getTrack 0 Feb 18 00:06:13 volumio volumio[1285]: info: CoreCommandRouter::volumioPushState Feb 18 00:06:13 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 18 00:06:13 volumio volumio[1285]: info: mDNS: A device disapperared from network Feb 18 00:06:13 volumio volumio[1285]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Feb 18 00:06:13 volumio volumio[1285]: info: Feb 18 00:06:13 volumio volumio[1285]: info: Starting Shairport Sync Feb 18 00:06:13 volumio volumio[1285]: info: Starting Shairport Sync Feb 18 00:06:13 volumio sudo[1575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 18 00:06:13 volumio sudo[1575]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 00:06:13 volumio sudo[1577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 18 00:06:13 volumio sudo[1577]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 00:06:13 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Feb 18 00:06:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 18 00:06:13 volumio systemd[1588]: Failed at step USER spawning /usr/local/bin/shairport-sync: No such process Feb 18 00:06:13 volumio sudo[1584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 18 00:06:13 volumio sudo[1584]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 18 00:06:13 volumio volumio[1285]: info: ControllerAutoPlay - mpd ready Feb 18 00:06:13 volumio systemd[1]: shairport-sync.service: main process exited, code=exited, status=217/USER Feb 18 00:06:13 volumio systemd[1]: Unit shairport-sync.service entered failed state. Feb 18 00:06:13 volumio sudo[1575]: pam_unix(sudo:session): session closed for user root Feb 18 00:06:13 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Feb 18 00:06:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 18 00:06:13 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Feb 18 00:06:13 volumio sudo[1577]: pam_unix(sudo:session): session closed for user root Feb 18 00:06:13 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Feb 18 00:06:13 volumio systemd[1597]: Failed at step USER spawning /usr/local/bin/shairport-sync: No such process Feb 18 00:06:13 volumio systemd[1]: shairport-sync.service: main process exited, code=exited, status=217/USER Feb 18 00:06:13 volumio systemd[1]: Unit shairport-sync.service entered failed state. Feb 18 00:06:13 volumio volumio[1285]: info: Shairport-Sync Started Feb 18 00:06:13 volumio volumio[1285]: Error adding Membership: Error: addMembership EINVAL Feb 18 00:06:13 volumio sudo[1584]: pam_unix(sudo:session): session closed for user root Feb 18 00:06:13 volumio volumio[1285]: info: Upmpdcli Daemon Started Feb 18 00:06:13 volumio volumio[1285]: info: Shairport-Sync Started Feb 18 00:06:13 volumio volumio[1285]: info: CoreCommandRouter::volumioGetState Feb 18 00:06:13 volumio volumio[1285]: info: CoreStateMachine::getState Feb 18 00:06:13 volumio volumio[1285]: info: CorePlayQueue::getTrack 0 Feb 18 00:06:15 volumio volumio-remote-updater[568]: [2025-02-18 00:06:15] [connect] Successful connection Feb 18 00:06:15 volumio volumio-remote-updater[568]: [2025-02-18 00:06:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1739837175 101 Feb 18 00:06:15 volumio wpa_supplicant[1150]: wlan0: Trying to associate with SSID 'VulkanTS' Feb 18 00:06:16 volumio volumio[1285]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 00:06:16 volumio volumio[1285]: { Error: addMembership ENODEV Feb 18 00:06:16 volumio volumio[1285]: at _errnoException (util.js:1022:11) Feb 18 00:06:16 volumio volumio[1285]: at Socket.addMembership (dgram.js:615:11) Feb 18 00:06:16 volumio volumio[1285]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) Feb 18 00:06:16 volumio volumio[1285]: at ontimeout (timers.js:482:11) Feb 18 00:06:16 volumio volumio[1285]: at tryOnTimeout (timers.js:317:5) Feb 18 00:06:16 volumio volumio[1285]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Feb 18 00:06:16 volumio volumio[1285]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 00:06:18 volumio wpa_supplicant[1150]: wlan0: Associated with e0:28:6d:de:6a:e8 Feb 18 00:06:18 volumio wpa_supplicant[1150]: wlan0: WPA: Key negotiation completed with e0:28:6d:de:6a:e8 [PTK=CCMP GTK=CCMP] Feb 18 00:06:18 volumio wpa_supplicant[1150]: wlan0: CTRL-EVENT-CONNECTED - Connection to e0:28:6d:de:6a:e8 completed [id=1 id_str=] Feb 18 00:06:18 volumio dhcpcd[1273]: wlan0: carrier acquired Feb 18 00:06:18 volumio wpa_supplicant[1150]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Feb 18 00:06:18 volumio dhcpcd[1273]: wlan0: rebinding lease of 10.0.4.5 Feb 18 00:06:18 volumio dhcpcd[1273]: wlan0: leased 10.0.4.5 for 864000 seconds Feb 18 00:06:18 volumio avahi-daemon[624]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.4.5. Feb 18 00:06:18 volumio avahi-daemon[624]: New relevant interface wlan0.IPv4 for mDNS. Feb 18 00:06:18 volumio dhcpcd[1273]: wlan0: adding host route to 10.0.4.5 via 127.0.0.1 Feb 18 00:06:18 volumio avahi-daemon[624]: Registering new address record for 10.0.4.5 on wlan0.IPv4. Feb 18 00:06:18 volumio dhcpcd[1273]: wlan0: adding route to 10.0.4.0/24 Feb 18 00:06:18 volumio dhcpcd[1273]: wlan0: adding default route via 10.0.4.1 Feb 18 00:06:18 volumio sudo[1695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-18 00:05 Feb 18 00:06:18 volumio sudo[1695]: 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="80e3a7415791a01dac7cd7cc2cc0a3d3fc65ba9d" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="a5d5fb6aa4e4c71be85580a005adf6b2009366a5" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Jan 16 20:23:20 CET 2020" VOLUMIO_VERSION="2.698" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="3dcbb012a2043e1c4181cb54ce618cae"