-- Logs begin at Fri 2025-03-07 22:47:27 +10, end at Fri 2025-03-07 23:02:18 +10. -- Mar 07 23:01:04 volumio go-librespot[1766]: time="2025-03-07T23:01:04+10:00" level=debug msg="fetched chunk 11/26, size: 524288" uri="spotify:track:16pMQoOFnPuFw0TzcUxNrc" Mar 07 23:01:16 volumio go-librespot[1766]: time="2025-03-07T23:01:16+10:00" level=debug msg="fetched chunk 12/26, size: 524288" uri="spotify:track:16pMQoOFnPuFw0TzcUxNrc" Mar 07 23:01:28 volumio go-librespot[1766]: time="2025-03-07T23:01:28+10:00" level=debug msg="fetched chunk 13/26, size: 524288" uri="spotify:track:16pMQoOFnPuFw0TzcUxNrc" Mar 07 23:01:40 volumio go-librespot[1766]: time="2025-03-07T23:01:40+10:00" level=debug msg="fetched chunk 14/26, size: 524288" uri="spotify:track:16pMQoOFnPuFw0TzcUxNrc" Mar 07 23:01:52 volumio go-librespot[1766]: time="2025-03-07T23:01:52+10:00" level=debug msg="fetched chunk 15/26, size: 524288" uri="spotify:track:16pMQoOFnPuFw0TzcUxNrc" Mar 07 23:02:03 volumio go-librespot[1766]: time="2025-03-07T23:02:03+10:00" level=debug msg="fetched chunk 16/26, size: 524288" uri="spotify:track:16pMQoOFnPuFw0TzcUxNrc" Mar 07 23:02:08 volumio dhcpcd[1579]: eth0: carrier lost Mar 07 23:02:08 volumio kernel: macb 1f00100000.ethernet eth0: Link is Down Mar 07 23:02:08 volumio dhcpcd[1579]: eth0: deleting route to 192.168.1.0/24 Mar 07 23:02:08 volumio avahi-daemon[805]: Withdrawing address record for 192.168.1.146 on eth0. Mar 07 23:02:08 volumio avahi-daemon[805]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.146. Mar 07 23:02:08 volumio avahi-daemon[805]: Interface eth0.IPv4 no longer relevant for mDNS. Mar 07 23:02:08 volumio dhcpcd[1579]: eth0: deleting default route via 192.168.1.1 Mar 07 23:02:08 volumio volumio[1464]: info: Discovery: A device disappeared from network Mar 07 23:02:08 volumio volumio[1464]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Mar 07 23:02:08 volumio ifplugd(eth0)[1003]: Link beat lost. Mar 07 23:02:09 volumio volumio[1464]: info: Volumio Network Manager: Network status updated: 0 Mar 07 23:02:09 volumio volumio[1464]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 23:02:09 volumio volumio[1464]: Error: send ENETUNREACH 255.255.255.255:3483 Mar 07 23:02:09 volumio volumio[1464]: at doSend (dgram.js:692:16) Mar 07 23:02:09 volumio volumio[1464]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Mar 07 23:02:09 volumio volumio[1464]: at afterDns (dgram.js:638:5) Mar 07 23:02:09 volumio volumio[1464]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Mar 07 23:02:09 volumio volumio[1464]: errno: -101, Mar 07 23:02:09 volumio volumio[1464]: code: 'ENETUNREACH', Mar 07 23:02:09 volumio volumio[1464]: syscall: 'send', Mar 07 23:02:09 volumio volumio[1464]: address: '255.255.255.255', Mar 07 23:02:09 volumio volumio[1464]: port: 3483 Mar 07 23:02:09 volumio volumio[1464]: } Mar 07 23:02:09 volumio volumio[1464]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 23:02:09 volumio ntpd[993]: Deleting interface #9 eth0, 192.168.1.146#123, interface stats: received=23, sent=23, dropped=0, active_time=72 secs Mar 07 23:02:09 volumio ntpd[993]: 192.36.143.130 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 212.113.99.6 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 89.108.115.94 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 151.0.2.53 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 45.141.102.99 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 188.246.226.170 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 95.79.30.113 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 51.250.110.169 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 94.131.113.113 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 5.188.119.216 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 5.178.87.15 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 193.35.49.242 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 151.0.2.54 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 188.124.37.90 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 93.95.98.77 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 45.90.217.6 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio ntpd[993]: 193.106.93.116 local addr 192.168.1.146 -> Mar 07 23:02:09 volumio sudo[4887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-07 23:01 Mar 07 23:02:09 volumio sudo[4887]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:09 volumio sudo[4887]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:09 volumio volumio-remote-updater[795]: [2025-03-07 23:02:09] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 07 23:02:09 volumio volumio-remote-updater[795]: [2025-03-07 23:02:09] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 07 23:02:09 volumio go-librespot[1766]: time="2025-03-07T23:02:09+10:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Mar 07 23:02:09 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 07 23:02:09 volumio ntfs-3g[1524]: Unmounting /dev/sda1 (M) Mar 07 23:02:09 volumio systemd[1]: media-M.mount: Succeeded. Mar 07 23:02:09 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 07 23:02:09 volumio systemd[1]: Started dynamicswap service. Mar 07 23:02:09 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 07 23:02:10 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 07 23:02:10 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Mar 07 23:02:10 volumio systemd[1]: Started dynamicswap service. Mar 07 23:02:10 volumio systemd[1]: Stopped Volumio Backend Module. Mar 07 23:02:10 volumio systemd[1]: Started Volumio Backend Module. Mar 07 23:02:10 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 07 23:02:10 volumio volumio[4904]: info: ------------------------------------------- Mar 07 23:02:10 volumio volumio[4904]: info: ----- Volumio3 ---- Mar 07 23:02:10 volumio volumio[4904]: info: ------------------------------------------- Mar 07 23:02:10 volumio volumio[4904]: info: ----- System startup ---- Mar 07 23:02:10 volumio volumio[4904]: info: ------------------------------------------- Mar 07 23:02:10 volumio volumio[4904]: info: MYVOLUMIO Environment detected Mar 07 23:02:10 volumio volumio[4904]: info: Plugin folders cleanup Mar 07 23:02:10 volumio volumio[4904]: info: Scanning into folder /volumio/app/plugins/ Mar 07 23:02:10 volumio volumio[4904]: info: Scanning category audio_interface Mar 07 23:02:10 volumio volumio[4904]: info: Scanning category miscellanea Mar 07 23:02:10 volumio volumio[4904]: info: Scanning category music_service Mar 07 23:02:10 volumio volumio[4904]: info: Scanning category plugins.json Mar 07 23:02:10 volumio volumio[4904]: info: Scanning category system_controller Mar 07 23:02:10 volumio volumio[4904]: info: Scanning category user_interface Mar 07 23:02:10 volumio volumio[4904]: info: Scanning into folder /data/plugins/ Mar 07 23:02:10 volumio volumio[4904]: info: Scanning category music_service Mar 07 23:02:10 volumio volumio[4904]: info: Scanning category system_hardware Mar 07 23:02:10 volumio volumio[4904]: info: Scanning category user_interface Mar 07 23:02:10 volumio volumio[4904]: info: Plugin folders cleanup completed Mar 07 23:02:10 volumio volumio[4904]: info: ------------------------------------------- Mar 07 23:02:10 volumio volumio[4904]: info: ----- Core plugins startup ---- Mar 07 23:02:10 volumio volumio[4904]: info: ------------------------------------------- Mar 07 23:02:10 volumio volumio[4904]: info: Loading plugins from folder /volumio/app/plugins/ Mar 07 23:02:10 volumio volumio[4904]: info: Adding plugin upnp to MyMusic Plugins Mar 07 23:02:10 volumio volumio[4904]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 07 23:02:10 volumio volumio[4904]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 07 23:02:10 volumio volumio[4904]: info: Loading plugins from folder /data/plugins/ Mar 07 23:02:10 volumio volumio[4904]: info: Loading plugin "system"... Mar 07 23:02:10 volumio volumio[4904]: info: Loading plugin "appearance"... Mar 07 23:02:10 volumio volumio[4904]: info: Loading plugin "network"... Mar 07 23:02:10 volumio volumio[4904]: info: Refreshing Cached IP Addresses Mar 07 23:02:10 volumio sudo[4932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 07 23:02:10 volumio sudo[4932]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:10 volumio sudo[4934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 07 23:02:10 volumio sudo[4934]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:10 volumio sudo[4932]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:10 volumio volumio[4904]: info: Loading plugin "services"... Mar 07 23:02:10 volumio sudo[4934]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:10 volumio volumio[4904]: info: Loading plugin "alsa_controller"... Mar 07 23:02:10 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:10 volumio volumio[4904]: info: Loading plugin "wizard"... Mar 07 23:02:10 volumio volumio[4904]: info: Loading plugin "networkfs"... Mar 07 23:02:10 volumio volumio[4904]: info: Cannot mount NAS Synology_NAS at system boot, trial number 1 ,retrying in 5 seconds Mar 07 23:02:10 volumio volumio[4904]: info: Starting Udev Watcher for removable devices Mar 07 23:02:10 volumio volumio[4904]: info: Mounting Device M Mar 07 23:02:10 volumio sudo[4958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/M -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 07 23:02:10 volumio sudo[4958]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:11 volumio ntfs-3g[4961]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 07 23:02:11 volumio ntfs-3g[4961]: Mounted /dev/sda1 (Read-Write, label "M", NTFS 3.1) Mar 07 23:02:11 volumio ntfs-3g[4961]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 07 23:02:11 volumio ntfs-3g[4961]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 07 23:02:11 volumio ntfs-3g[4961]: Global ownership and permissions enforced, configuration type 7 Mar 07 23:02:11 volumio sudo[4958]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:11 volumio volumio[4904]: info: Ignoring mount for partition: boot Mar 07 23:02:11 volumio volumio[4904]: info: Ignoring mount for partition: volumio Mar 07 23:02:11 volumio volumio[4904]: info: Ignoring mount for partition: volumio_data Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "volumio_command_line_client"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "upnp"... Mar 07 23:02:11 volumio volumio[4904]: info: [1741352531093] Starting Upmpd Daemon Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "my_music"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "mpd"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "upnp_browser"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "alarm-clock"... Mar 07 23:02:11 volumio volumio[4904]: info: Plugin airplay_emulation is not enabled Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "last_100"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "webradio"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "i2s_dacs"... Mar 07 23:02:11 volumio volumio[4904]: info: I2S DAC not set, start Auto-detection Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "volumiodiscovery"... Mar 07 23:02:11 volumio volumio[4904]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:11 volumio volumio[4904]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:11 volumio volumio[4904]: *** WARNING *** For more information see Mar 07 23:02:11 volumio volumio[4904]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:11 volumio volumio[4904]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:11 volumio volumio[4904]: *** WARNING *** For more information see Mar 07 23:02:11 volumio node[4904]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:11 volumio node[4904]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:11 volumio node[4904]: *** WARNING *** For more information see Mar 07 23:02:11 volumio node[4904]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:11 volumio node[4904]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:11 volumio node[4904]: *** WARNING *** For more information see Mar 07 23:02:11 volumio volumio[4904]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 07 23:02:11 volumio volumio[4904]: info: Discovery: Started advertising with name: Volumio Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "spop"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "squeezelite_mc"... Mar 07 23:02:11 volumio volumio[4904]: info: Plugin peppy_screensaver is not enabled Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "outputs"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "albumart"... Mar 07 23:02:11 volumio volumio[4904]: info: Plugin example_plugin is not enabled Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "inputs"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "updater_comm"... Mar 07 23:02:11 volumio volumio[4904]: info: Plugin mpdemulation is not enabled Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "rest_api"... Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "websocket"... Mar 07 23:02:11 volumio volumio[4904]: info: Starting Socket.io Server version 2.3.0 Mar 07 23:02:11 volumio volumio[4904]: info: Plugin music_services_shield is not enabled Mar 07 23:02:11 volumio volumio[4904]: info: Plugin Systeminfo is not enabled Mar 07 23:02:11 volumio volumio[4904]: info: Loading plugin "touch_display"... Mar 07 23:02:11 volumio volumio[4904]: Forking 3 albumart workers Mar 07 23:02:11 volumio volumio[4904]: info: Applying required configuration parameters for plugin touch_display Mar 07 23:02:11 volumio volumio[4904]: info: Loading i18n strings for locale en Mar 07 23:02:11 volumio volumio[4904]: Updating browse sources language Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::initPlayerControls Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:11 volumio volumio[4904]: Express server listening on port 3000 Mar 07 23:02:11 volumio volumio[4904]: [Metrics] WebUI: 1s 685.26ms Mar 07 23:02:11 volumio volumio[4904]: info: CoreStateMachine::resetVolumioState Mar 07 23:02:11 volumio volumio[4904]: info: CoreStateMachine::getcurrentVolume Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::volumioRetrievevolume Mar 07 23:02:11 volumio volumio[4904]: info: CoreStateMachine::pushState Mar 07 23:02:11 volumio volumio[4904]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 07 23:02:11 volumio volumio[4904]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 23:02:12 volumio volumio[4904]: info: Volumio Network Manager: Network status updated: 0 Mar 07 23:02:12 volumio volumio[4904]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Mar 07 23:02:12 volumio volumio[4904]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 07 23:02:12 volumio volumio[4904]: info: Reloading queue from file Mar 07 23:02:12 volumio volumio[4904]: Starting albumart workers Mar 07 23:02:12 volumio volumio[4904]: Starting albumart workers Mar 07 23:02:12 volumio volumio[4904]: info: CoreStateMachine::setRepeat null single undefined Mar 07 23:02:12 volumio volumio[4904]: info: CoreStateMachine::pushState Mar 07 23:02:12 volumio volumio[4904]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:12 volumio volumio[4904]: info: CoreStateMachine::setRandom null Mar 07 23:02:12 volumio volumio[4904]: info: CoreStateMachine::pushState Mar 07 23:02:12 volumio volumio[4904]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:12 volumio volumio[4904]: Starting albumart workers Mar 07 23:02:12 volumio volumio[4904]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 07 23:02:12 volumio volumio[4904]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Mar 07 23:02:12 volumio volumio[4904]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 07 23:02:12 volumio volumio[4904]: info: Setting Device type: Raspberry PI Mar 07 23:02:12 volumio volumio[4904]: info: Completed loading Core Plugins Mar 07 23:02:12 volumio volumio[4904]: info: Preparing to generate the ALSA configuration file Mar 07 23:02:12 volumio volumio[4904]: info: Asound.conf file unchanged, so no further update is needed Mar 07 23:02:12 volumio volumio[4904]: info: Output device has changed, restarting MPD Mar 07 23:02:12 volumio volumio[4904]: info: ___________ START PLUGINS ___________ Mar 07 23:02:12 volumio sudo[5006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 07 23:02:12 volumio sudo[5006]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:12 volumio volumio[4904]: info: ControllerMpd::onStart: Initializing MPD Mar 07 23:02:12 volumio volumio[4904]: info: Creating MPD Configuration file Mar 07 23:02:12 volumio sudo[5007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 07 23:02:12 volumio sudo[5007]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:12 volumio sudo[5006]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 07 23:02:12 volumio volumio[4904]: info: [1741352532147] CoreMusicLibrary::Adding element Media Servers Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:12 volumio sudo[5011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 07 23:02:12 volumio sudo[5011]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 07 23:02:12 volumio volumio[4904]: info: [1741352532153] CoreMusicLibrary::Adding element Last_100 Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 07 23:02:12 volumio volumio[4904]: info: [1741352532156] CoreMusicLibrary::Adding element Webradio Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:12 volumio sudo[5011]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:12 volumio systemd[1]: Stopping Music Player Daemon... Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:12 volumio volumio[4904]: info: Initializing BBC Radios Mar 07 23:02:12 volumio sudo[5013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 07 23:02:12 volumio sudo[5013]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:12 volumio systemd[1]: mpd.service: Succeeded. Mar 07 23:02:12 volumio systemd[1]: Stopped Music Player Daemon. Mar 07 23:02:12 volumio systemd[1]: Starting Music Player Daemon... Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 23:02:12 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 07 23:02:12 volumio systemd[1]: mpd.service: Succeeded. Mar 07 23:02:12 volumio systemd[1]: Stopped Music Player Daemon. Mar 07 23:02:12 volumio systemd[1]: Starting Music Player Daemon... Mar 07 23:02:12 volumio volumio[4904]: info: Creating Spotify config file Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:12 volumio sudo[5027]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 07 23:02:12 volumio sudo[5027]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:12 volumio sudo[5027]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:12 volumio volumio[4904]: info: [squeezelite_mc] Starting proxy server... Mar 07 23:02:12 volumio volumio[4904]: info: Loading i18n strings for locale en Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:12 volumio volumio[4904]: info: Volumio Calling Home Mar 07 23:02:12 volumio volumio[4904]: info: [squeezelite_mc] Proxy server started on port 35613 Mar 07 23:02:12 volumio sudo[5059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Mar 07 23:02:12 volumio sudo[5059]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:12 volumio sudo[5062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::volumioRetrievevolume Mar 07 23:02:12 volumio sudo[5059]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:12 volumio volumio[4904]: info: CoreStateMachine::pushState Mar 07 23:02:12 volumio sudo[5062]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:12 volumio volumio[4904]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:12 volumio sudo[5064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 07 23:02:12 volumio sudo[5064]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:12 volumio volumio[4904]: info: [squeezelite_mc] Server discovery started Mar 07 23:02:12 volumio volumio[4904]: info: [squeezelite_mc] Player finder started Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:12 volumio volumio[4904]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:12 volumio volumio[4904]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Mar 07 23:02:12 volumio systemd[1]: Reloading. Mar 07 23:02:12 volumio volumio[4904]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 23:02:12 volumio volumio[4904]: Error: send ENETUNREACH 255.255.255.255:3483 Mar 07 23:02:12 volumio volumio[4904]: at doSend (dgram.js:692:16) Mar 07 23:02:12 volumio volumio[4904]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Mar 07 23:02:12 volumio volumio[4904]: at afterDns (dgram.js:638:5) Mar 07 23:02:12 volumio volumio[4904]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Mar 07 23:02:12 volumio volumio[4904]: errno: -101, Mar 07 23:02:12 volumio volumio[4904]: code: 'ENETUNREACH', Mar 07 23:02:12 volumio volumio[4904]: syscall: 'send', Mar 07 23:02:12 volumio volumio[4904]: address: '255.255.255.255', Mar 07 23:02:12 volumio volumio[4904]: port: 3483 Mar 07 23:02:12 volumio volumio[4904]: } Mar 07 23:02:12 volumio volumio[4904]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 23:02:12 volumio dhcpcd[1579]: eth0: carrier acquired Mar 07 23:02:12 volumio dhcpcd[1579]: eth0: IAID 67:1a:fa:79 Mar 07 23:02:12 volumio kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Mar 07 23:02:12 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 07 23:02:12 volumio sudo[5093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-07 23:01 Mar 07 23:02:12 volumio sudo[5093]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:12 volumio sudo[5093]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:12 volumio mpd[5037]: Mar 07 23:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 07 23:02:12 volumio ifplugd(eth0)[1003]: Link beat detected. Mar 07 23:02:12 volumio systemd[1]: Started Music Player Daemon. Mar 07 23:02:12 volumio sudo[5064]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:12 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 07 23:02:12 volumio sudo[5013]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:12 volumio ntfs-3g[4961]: Unmounting /dev/sda1 (M) Mar 07 23:02:12 volumio sudo[5062]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:12 volumio sudo[5007]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:12 volumio systemd[1]: media-M.mount: Succeeded. Mar 07 23:02:12 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 07 23:02:12 volumio systemd[1]: Started dynamicswap service. Mar 07 23:02:12 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 07 23:02:12 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 07 23:02:12 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Mar 07 23:02:12 volumio systemd[1]: Started dynamicswap service. Mar 07 23:02:12 volumio systemd[1]: Stopped Volumio Backend Module. Mar 07 23:02:12 volumio systemd[1]: Started Volumio Backend Module. Mar 07 23:02:12 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 07 23:02:13 volumio volumio[5110]: info: ------------------------------------------- Mar 07 23:02:13 volumio volumio[5110]: info: ----- Volumio3 ---- Mar 07 23:02:13 volumio volumio[5110]: info: ------------------------------------------- Mar 07 23:02:13 volumio volumio[5110]: info: ----- System startup ---- Mar 07 23:02:13 volumio volumio[5110]: info: ------------------------------------------- Mar 07 23:02:13 volumio dhcpcd[1579]: eth0: rebinding lease of 192.168.1.146 Mar 07 23:02:13 volumio volumio[5110]: info: MYVOLUMIO Environment detected Mar 07 23:02:13 volumio volumio[5110]: info: Plugin folders cleanup Mar 07 23:02:13 volumio volumio[5110]: info: Scanning into folder /volumio/app/plugins/ Mar 07 23:02:13 volumio volumio[5110]: info: Scanning category audio_interface Mar 07 23:02:13 volumio volumio[5110]: info: Scanning category miscellanea Mar 07 23:02:13 volumio volumio[5110]: info: Scanning category music_service Mar 07 23:02:13 volumio volumio[5110]: info: Scanning category plugins.json Mar 07 23:02:13 volumio volumio[5110]: info: Scanning category system_controller Mar 07 23:02:13 volumio volumio[5110]: info: Scanning category user_interface Mar 07 23:02:13 volumio volumio[5110]: info: Scanning into folder /data/plugins/ Mar 07 23:02:13 volumio volumio[5110]: info: Scanning category music_service Mar 07 23:02:13 volumio volumio[5110]: info: Scanning category system_hardware Mar 07 23:02:13 volumio volumio[5110]: info: Scanning category user_interface Mar 07 23:02:13 volumio volumio[5110]: info: Plugin folders cleanup completed Mar 07 23:02:13 volumio volumio[5110]: info: ------------------------------------------- Mar 07 23:02:13 volumio volumio[5110]: info: ----- Core plugins startup ---- Mar 07 23:02:13 volumio volumio[5110]: info: ------------------------------------------- Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugins from folder /volumio/app/plugins/ Mar 07 23:02:13 volumio volumio[5110]: info: Adding plugin upnp to MyMusic Plugins Mar 07 23:02:13 volumio volumio[5110]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 07 23:02:13 volumio volumio[5110]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugins from folder /data/plugins/ Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "system"... Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "appearance"... Mar 07 23:02:13 volumio dhcpcd[1579]: eth0: soliciting an IPv6 router Mar 07 23:02:13 volumio dhcpcd[1579]: eth0: probing address 192.168.1.146/24 Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "network"... Mar 07 23:02:13 volumio volumio[5110]: info: Refreshing Cached IP Addresses Mar 07 23:02:13 volumio sudo[5136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 07 23:02:13 volumio sudo[5136]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:13 volumio sudo[5136]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:13 volumio sudo[5138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 07 23:02:13 volumio sudo[5138]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "services"... Mar 07 23:02:13 volumio sudo[5138]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "alsa_controller"... Mar 07 23:02:13 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "wizard"... Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "networkfs"... Mar 07 23:02:13 volumio volumio[5110]: info: Cannot mount NAS Synology_NAS at system boot, trial number 1 ,retrying in 5 seconds Mar 07 23:02:13 volumio volumio[5110]: info: Starting Udev Watcher for removable devices Mar 07 23:02:13 volumio volumio[5110]: info: Mounting Device M Mar 07 23:02:13 volumio sudo[5162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/M -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 07 23:02:13 volumio sudo[5162]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:13 volumio ntfs-3g[5165]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 07 23:02:13 volumio ntfs-3g[5165]: Mounted /dev/sda1 (Read-Write, label "M", NTFS 3.1) Mar 07 23:02:13 volumio ntfs-3g[5165]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 07 23:02:13 volumio ntfs-3g[5165]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 07 23:02:13 volumio ntfs-3g[5165]: Global ownership and permissions enforced, configuration type 7 Mar 07 23:02:13 volumio sudo[5162]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:13 volumio volumio[5110]: info: Ignoring mount for partition: boot Mar 07 23:02:13 volumio volumio[5110]: info: Ignoring mount for partition: volumio Mar 07 23:02:13 volumio volumio[5110]: info: Ignoring mount for partition: volumio_data Mar 07 23:02:13 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "volumio_command_line_client"... Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "upnp"... Mar 07 23:02:13 volumio volumio[5110]: info: [1741352533875] Starting Upmpd Daemon Mar 07 23:02:13 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "my_music"... Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "mpd"... Mar 07 23:02:13 volumio volumio[5110]: info: Loading plugin "upnp_browser"... Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "alarm-clock"... Mar 07 23:02:14 volumio volumio[5110]: info: Plugin airplay_emulation is not enabled Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "last_100"... Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "webradio"... Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "i2s_dacs"... Mar 07 23:02:14 volumio volumio[5110]: info: I2S DAC not set, start Auto-detection Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "volumiodiscovery"... Mar 07 23:02:14 volumio volumio[5110]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:14 volumio volumio[5110]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:14 volumio volumio[5110]: *** WARNING *** For more information see Mar 07 23:02:14 volumio volumio[5110]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:14 volumio node[5110]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:14 volumio volumio[5110]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:14 volumio volumio[5110]: *** WARNING *** For more information see Mar 07 23:02:14 volumio node[5110]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:14 volumio node[5110]: *** WARNING *** For more information see Mar 07 23:02:14 volumio node[5110]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:14 volumio node[5110]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:14 volumio node[5110]: *** WARNING *** For more information see Mar 07 23:02:14 volumio volumio[5110]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 07 23:02:14 volumio volumio[5110]: info: Discovery: Started advertising with name: Volumio Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "spop"... Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "squeezelite_mc"... Mar 07 23:02:14 volumio volumio[5110]: info: Plugin peppy_screensaver is not enabled Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "outputs"... Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "albumart"... Mar 07 23:02:14 volumio volumio[5110]: info: Plugin example_plugin is not enabled Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "inputs"... Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "updater_comm"... Mar 07 23:02:14 volumio volumio[5110]: info: Plugin mpdemulation is not enabled Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "rest_api"... Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "websocket"... Mar 07 23:02:14 volumio volumio[5110]: info: Starting Socket.io Server version 2.3.0 Mar 07 23:02:14 volumio volumio[5110]: info: Plugin music_services_shield is not enabled Mar 07 23:02:14 volumio volumio[5110]: info: Plugin Systeminfo is not enabled Mar 07 23:02:14 volumio volumio[5110]: info: Loading plugin "touch_display"... Mar 07 23:02:14 volumio volumio[5110]: Forking 3 albumart workers Mar 07 23:02:14 volumio volumio[5110]: info: Applying required configuration parameters for plugin touch_display Mar 07 23:02:14 volumio volumio[5110]: info: Loading i18n strings for locale en Mar 07 23:02:14 volumio volumio[5110]: Updating browse sources language Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::initPlayerControls Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: Express server listening on port 3000 Mar 07 23:02:14 volumio volumio[5110]: [Metrics] WebUI: 1s 712.61ms Mar 07 23:02:14 volumio volumio[5110]: info: CoreStateMachine::resetVolumioState Mar 07 23:02:14 volumio volumio[5110]: info: CoreStateMachine::getcurrentVolume Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::volumioRetrievevolume Mar 07 23:02:14 volumio volumio[5110]: info: CoreStateMachine::pushState Mar 07 23:02:14 volumio volumio[5110]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: Volumio Network Manager: Network status updated: 0 Mar 07 23:02:14 volumio volumio[5110]: Starting albumart workers Mar 07 23:02:14 volumio volumio[5110]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Mar 07 23:02:14 volumio volumio[5110]: Starting albumart workers Mar 07 23:02:14 volumio volumio[5110]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 07 23:02:14 volumio volumio[5110]: info: Reloading queue from file Mar 07 23:02:14 volumio volumio[5110]: Starting albumart workers Mar 07 23:02:14 volumio volumio[5110]: info: CoreStateMachine::setRepeat null single undefined Mar 07 23:02:14 volumio volumio[5110]: info: CoreStateMachine::pushState Mar 07 23:02:14 volumio volumio[5110]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:14 volumio volumio[5110]: info: CoreStateMachine::setRandom null Mar 07 23:02:14 volumio volumio[5110]: info: CoreStateMachine::pushState Mar 07 23:02:14 volumio volumio[5110]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:14 volumio volumio[5110]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 07 23:02:14 volumio volumio[5110]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Mar 07 23:02:14 volumio volumio[5110]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 07 23:02:14 volumio volumio-remote-updater[795]: [2025-03-07 23:02:14] [connect] Successful connection Mar 07 23:02:14 volumio volumio[5110]: info: Setting Device type: Raspberry PI Mar 07 23:02:14 volumio volumio-remote-updater[795]: [2025-03-07 23:02:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741352534 101 Mar 07 23:02:14 volumio volumio[5110]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Mar 07 23:02:14 volumio volumio[5110]: info: Completed loading Core Plugins Mar 07 23:02:14 volumio volumio[5110]: info: Preparing to generate the ALSA configuration file Mar 07 23:02:14 volumio volumio[5110]: info: Asound.conf file unchanged, so no further update is needed Mar 07 23:02:14 volumio volumio[5110]: info: Output device has changed, restarting MPD Mar 07 23:02:14 volumio volumio[5110]: info: ___________ START PLUGINS ___________ Mar 07 23:02:14 volumio volumio[5110]: info: ControllerMpd::onStart: Initializing MPD Mar 07 23:02:14 volumio volumio[5110]: info: Creating MPD Configuration file Mar 07 23:02:14 volumio sudo[5206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 07 23:02:14 volumio sudo[5206]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:14 volumio sudo[5208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 07 23:02:14 volumio sudo[5208]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:14 volumio systemd[1]: Stopping Music Player Daemon... Mar 07 23:02:14 volumio sudo[5206]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 07 23:02:14 volumio volumio[5110]: info: [1741352534956] CoreMusicLibrary::Adding element Media Servers Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:14 volumio sudo[5210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 07 23:02:14 volumio sudo[5210]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:14 volumio sudo[5214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 07 23:02:14 volumio systemd[1]: mpd.service: Succeeded. Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 07 23:02:14 volumio volumio[5110]: info: [1741352534964] CoreMusicLibrary::Adding element Last_100 Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 07 23:02:14 volumio volumio[5110]: info: [1741352534965] CoreMusicLibrary::Adding element Webradio Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:14 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:14 volumio volumio[5110]: info: Initializing BBC Radios Mar 07 23:02:14 volumio sudo[5214]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:14 volumio systemd[1]: Stopped Music Player Daemon. Mar 07 23:02:14 volumio sudo[5210]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:14 volumio systemd[1]: Starting Music Player Daemon... Mar 07 23:02:15 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 07 23:02:15 volumio systemd[1]: mpd.service: Succeeded. Mar 07 23:02:15 volumio systemd[1]: Stopped Music Player Daemon. Mar 07 23:02:15 volumio systemd[1]: Starting Music Player Daemon... Mar 07 23:02:15 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:15 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 23:02:15 volumio volumio[5110]: info: Creating Spotify config file Mar 07 23:02:15 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:15 volumio sudo[5229]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 07 23:02:15 volumio sudo[5229]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:15 volumio sudo[5229]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:15 volumio volumio[5110]: info: [squeezelite_mc] Starting proxy server... Mar 07 23:02:15 volumio volumio[5110]: info: Loading i18n strings for locale en Mar 07 23:02:15 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:15 volumio volumio[5110]: info: Volumio Calling Home Mar 07 23:02:15 volumio volumio[5110]: info: [squeezelite_mc] Proxy server started on port 41863 Mar 07 23:02:15 volumio sudo[5260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Mar 07 23:02:15 volumio sudo[5260]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:15 volumio sudo[5263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Mar 07 23:02:15 volumio sudo[5263]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:15 volumio volumio[5110]: info: CoreCommandRouter::volumioRetrievevolume Mar 07 23:02:15 volumio sudo[5265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 07 23:02:15 volumio sudo[5265]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:15 volumio volumio[5110]: info: CoreStateMachine::pushState Mar 07 23:02:15 volumio volumio[5110]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:15 volumio volumio[5110]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:15 volumio sudo[5260]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:15 volumio systemd[1]: Reloading. Mar 07 23:02:15 volumio volumio[5110]: info: [squeezelite_mc] Server discovery started Mar 07 23:02:15 volumio volumio[5110]: info: [squeezelite_mc] Player finder started Mar 07 23:02:15 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:15 volumio volumio[5110]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:15 volumio volumio[5110]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Mar 07 23:02:15 volumio volumio[5110]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 23:02:15 volumio volumio[5110]: Error: send ENETUNREACH 255.255.255.255:3483 Mar 07 23:02:15 volumio volumio[5110]: at doSend (dgram.js:692:16) Mar 07 23:02:15 volumio volumio[5110]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Mar 07 23:02:15 volumio volumio[5110]: at afterDns (dgram.js:638:5) Mar 07 23:02:15 volumio volumio[5110]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Mar 07 23:02:15 volumio volumio[5110]: errno: -101, Mar 07 23:02:15 volumio volumio[5110]: code: 'ENETUNREACH', Mar 07 23:02:15 volumio volumio[5110]: syscall: 'send', Mar 07 23:02:15 volumio volumio[5110]: address: '255.255.255.255', Mar 07 23:02:15 volumio volumio[5110]: port: 3483 Mar 07 23:02:15 volumio volumio[5110]: } Mar 07 23:02:15 volumio volumio[5110]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 23:02:15 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 07 23:02:15 volumio sudo[5292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-07 23:01 Mar 07 23:02:15 volumio sudo[5292]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:15 volumio mpd[5247]: Mar 07 23:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 07 23:02:15 volumio sudo[5292]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:15 volumio volumio-remote-updater[795]: [2025-03-07 23:02:15] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 07 23:02:15 volumio volumio-remote-updater[795]: [2025-03-07 23:02:15] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 07 23:02:15 volumio systemd[1]: Started Music Player Daemon. Mar 07 23:02:15 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 07 23:02:15 volumio sudo[5214]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:15 volumio sudo[5208]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:15 volumio systemd[1]: media-M.mount: Succeeded. Mar 07 23:02:15 volumio sudo[5265]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:15 volumio sudo[5263]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:15 volumio ntfs-3g[5165]: Unmounting /dev/sda1 (M) Mar 07 23:02:15 volumio systemd[1]: Starting Cleanup of Temporary Directories... Mar 07 23:02:15 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 07 23:02:15 volumio systemd[1]: Started dynamicswap service. Mar 07 23:02:15 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 07 23:02:15 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Mar 07 23:02:15 volumio systemd[1]: Started Cleanup of Temporary Directories. Mar 07 23:02:15 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 07 23:02:15 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. Mar 07 23:02:15 volumio systemd[1]: Started dynamicswap service. Mar 07 23:02:15 volumio systemd[1]: Stopped Volumio Backend Module. Mar 07 23:02:15 volumio systemd[1]: Started Volumio Backend Module. Mar 07 23:02:15 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 07 23:02:16 volumio volumio[5309]: info: ------------------------------------------- Mar 07 23:02:16 volumio volumio[5309]: info: ----- Volumio3 ---- Mar 07 23:02:16 volumio volumio[5309]: info: ------------------------------------------- Mar 07 23:02:16 volumio volumio[5309]: info: ----- System startup ---- Mar 07 23:02:16 volumio volumio[5309]: info: ------------------------------------------- Mar 07 23:02:16 volumio volumio[5309]: info: MYVOLUMIO Environment detected Mar 07 23:02:16 volumio volumio[5309]: info: Plugin folders cleanup Mar 07 23:02:16 volumio volumio[5309]: info: Scanning into folder /volumio/app/plugins/ Mar 07 23:02:16 volumio volumio[5309]: info: Scanning category audio_interface Mar 07 23:02:16 volumio volumio[5309]: info: Scanning category miscellanea Mar 07 23:02:16 volumio volumio[5309]: info: Scanning category music_service Mar 07 23:02:16 volumio volumio[5309]: info: Scanning category plugins.json Mar 07 23:02:16 volumio volumio[5309]: info: Scanning category system_controller Mar 07 23:02:16 volumio volumio[5309]: info: Scanning category user_interface Mar 07 23:02:16 volumio volumio[5309]: info: Scanning into folder /data/plugins/ Mar 07 23:02:16 volumio volumio[5309]: info: Scanning category music_service Mar 07 23:02:16 volumio volumio[5309]: info: Scanning category system_hardware Mar 07 23:02:16 volumio volumio[5309]: info: Scanning category user_interface Mar 07 23:02:16 volumio volumio[5309]: info: Plugin folders cleanup completed Mar 07 23:02:16 volumio volumio[5309]: info: ------------------------------------------- Mar 07 23:02:16 volumio volumio[5309]: info: ----- Core plugins startup ---- Mar 07 23:02:16 volumio volumio[5309]: info: ------------------------------------------- Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugins from folder /volumio/app/plugins/ Mar 07 23:02:16 volumio volumio[5309]: info: Adding plugin upnp to MyMusic Plugins Mar 07 23:02:16 volumio volumio[5309]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 07 23:02:16 volumio volumio[5309]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugins from folder /data/plugins/ Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "system"... Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "appearance"... Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "network"... Mar 07 23:02:16 volumio volumio[5309]: info: Refreshing Cached IP Addresses Mar 07 23:02:16 volumio sudo[5335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 07 23:02:16 volumio sudo[5335]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:16 volumio sudo[5335]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:16 volumio sudo[5337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 07 23:02:16 volumio sudo[5337]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "services"... Mar 07 23:02:16 volumio sudo[5337]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "alsa_controller"... Mar 07 23:02:16 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "wizard"... Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "networkfs"... Mar 07 23:02:16 volumio volumio[5309]: info: Cannot mount NAS Synology_NAS at system boot, trial number 1 ,retrying in 5 seconds Mar 07 23:02:16 volumio volumio[5309]: info: Starting Udev Watcher for removable devices Mar 07 23:02:16 volumio volumio[5309]: info: Mounting Device M Mar 07 23:02:16 volumio sudo[5361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/M -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 07 23:02:16 volumio sudo[5361]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:16 volumio ntfs-3g[5364]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 07 23:02:16 volumio ntfs-3g[5364]: Mounted /dev/sda1 (Read-Write, label "M", NTFS 3.1) Mar 07 23:02:16 volumio ntfs-3g[5364]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 07 23:02:16 volumio ntfs-3g[5364]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 07 23:02:16 volumio ntfs-3g[5364]: Global ownership and permissions enforced, configuration type 7 Mar 07 23:02:16 volumio sudo[5361]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:16 volumio volumio[5309]: info: Ignoring mount for partition: boot Mar 07 23:02:16 volumio volumio[5309]: info: Ignoring mount for partition: volumio Mar 07 23:02:16 volumio volumio[5309]: info: Ignoring mount for partition: volumio_data Mar 07 23:02:16 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "volumio_command_line_client"... Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "upnp"... Mar 07 23:02:16 volumio volumio[5309]: info: [1741352536878] Starting Upmpd Daemon Mar 07 23:02:16 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "my_music"... Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "mpd"... Mar 07 23:02:16 volumio volumio[5309]: info: Loading plugin "upnp_browser"... Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "alarm-clock"... Mar 07 23:02:17 volumio volumio[5309]: info: Plugin airplay_emulation is not enabled Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "last_100"... Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "webradio"... Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "i2s_dacs"... Mar 07 23:02:17 volumio volumio[5309]: info: I2S DAC not set, start Auto-detection Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "volumiodiscovery"... Mar 07 23:02:17 volumio volumio[5309]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:17 volumio node[5309]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:17 volumio node[5309]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:17 volumio volumio[5309]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:17 volumio volumio[5309]: *** WARNING *** For more information see Mar 07 23:02:17 volumio volumio[5309]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:17 volumio volumio[5309]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:17 volumio volumio[5309]: *** WARNING *** For more information see Mar 07 23:02:17 volumio node[5309]: *** WARNING *** For more information see Mar 07 23:02:17 volumio node[5309]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 07 23:02:17 volumio node[5309]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 07 23:02:17 volumio node[5309]: *** WARNING *** For more information see Mar 07 23:02:17 volumio volumio[5309]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 07 23:02:17 volumio volumio[5309]: info: Discovery: Started advertising with name: Volumio Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "spop"... Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "squeezelite_mc"... Mar 07 23:02:17 volumio volumio[5309]: info: Plugin peppy_screensaver is not enabled Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "outputs"... Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "albumart"... Mar 07 23:02:17 volumio volumio[5309]: info: Plugin example_plugin is not enabled Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "inputs"... Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "updater_comm"... Mar 07 23:02:17 volumio volumio[5309]: info: Plugin mpdemulation is not enabled Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "rest_api"... Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "websocket"... Mar 07 23:02:17 volumio volumio[5309]: info: Starting Socket.io Server version 2.3.0 Mar 07 23:02:17 volumio volumio[5309]: info: Plugin music_services_shield is not enabled Mar 07 23:02:17 volumio volumio[5309]: info: Plugin Systeminfo is not enabled Mar 07 23:02:17 volumio volumio[5309]: info: Loading plugin "touch_display"... Mar 07 23:02:17 volumio volumio[5309]: Forking 3 albumart workers Mar 07 23:02:17 volumio volumio[5309]: info: Applying required configuration parameters for plugin touch_display Mar 07 23:02:17 volumio volumio[5309]: info: Loading i18n strings for locale en Mar 07 23:02:17 volumio volumio[5309]: Updating browse sources language Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::initPlayerControls Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: Express server listening on port 3000 Mar 07 23:02:17 volumio volumio[5309]: [Metrics] WebUI: 1s 675.21ms Mar 07 23:02:17 volumio volumio[5309]: info: CoreStateMachine::resetVolumioState Mar 07 23:02:17 volumio volumio[5309]: info: CoreStateMachine::getcurrentVolume Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::volumioRetrievevolume Mar 07 23:02:17 volumio volumio[5309]: info: CoreStateMachine::pushState Mar 07 23:02:17 volumio volumio[5309]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: Volumio Network Manager: Network status updated: 0 Mar 07 23:02:17 volumio volumio[5309]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Mar 07 23:02:17 volumio volumio[5309]: Starting albumart workers Mar 07 23:02:17 volumio volumio[5309]: info: Reloading queue from file Mar 07 23:02:17 volumio volumio[5309]: info: CoreStateMachine::setRepeat null single undefined Mar 07 23:02:17 volumio volumio[5309]: info: CoreStateMachine::pushState Mar 07 23:02:17 volumio volumio[5309]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:17 volumio volumio[5309]: info: CoreStateMachine::setRandom null Mar 07 23:02:17 volumio volumio[5309]: info: CoreStateMachine::pushState Mar 07 23:02:17 volumio volumio[5309]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:17 volumio volumio[5309]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 07 23:02:17 volumio volumio[5309]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Mar 07 23:02:17 volumio volumio[5309]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 07 23:02:17 volumio volumio[5309]: info: Setting Device type: Raspberry PI Mar 07 23:02:17 volumio volumio[5309]: Starting albumart workers Mar 07 23:02:17 volumio volumio[5309]: Starting albumart workers Mar 07 23:02:17 volumio volumio[5309]: info: Completed loading Core Plugins Mar 07 23:02:17 volumio volumio[5309]: info: Preparing to generate the ALSA configuration file Mar 07 23:02:17 volumio volumio[5309]: info: Asound.conf file unchanged, so no further update is needed Mar 07 23:02:17 volumio volumio[5309]: info: Output device has changed, restarting MPD Mar 07 23:02:17 volumio sudo[5405]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 07 23:02:17 volumio sudo[5405]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:17 volumio volumio[5309]: info: ___________ START PLUGINS ___________ Mar 07 23:02:17 volumio sudo[5405]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:17 volumio volumio[5309]: info: ControllerMpd::onStart: Initializing MPD Mar 07 23:02:17 volumio volumio[5309]: info: Creating MPD Configuration file Mar 07 23:02:17 volumio sudo[5408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 07 23:02:17 volumio sudo[5408]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:17 volumio systemd[1]: Stopping Music Player Daemon... Mar 07 23:02:17 volumio systemd[1]: mpd.service: Succeeded. Mar 07 23:02:17 volumio systemd[1]: Stopped Music Player Daemon. Mar 07 23:02:17 volumio sudo[5412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 07 23:02:17 volumio sudo[5412]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 07 23:02:17 volumio volumio[5309]: info: [1741352537953] CoreMusicLibrary::Adding element Media Servers Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:17 volumio sudo[5415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 07 23:02:17 volumio systemd[1]: Starting Music Player Daemon... Mar 07 23:02:17 volumio sudo[5415]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:17 volumio sudo[5412]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 07 23:02:17 volumio volumio[5309]: info: [1741352537966] CoreMusicLibrary::Adding element Last_100 Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 07 23:02:17 volumio volumio[5309]: info: [1741352537967] CoreMusicLibrary::Adding element Webradio Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 07 23:02:17 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 07 23:02:17 volumio systemd[1]: mpd.service: Succeeded. Mar 07 23:02:17 volumio systemd[1]: Stopped Music Player Daemon. Mar 07 23:02:17 volumio systemd[1]: Starting Music Player Daemon... Mar 07 23:02:17 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:17 volumio volumio[5309]: info: Initializing BBC Radios Mar 07 23:02:18 volumio sudo[5417]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 07 23:02:18 volumio sudo[5417]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:18 volumio sudo[5417]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:18 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:18 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 07 23:02:18 volumio volumio[5309]: info: Creating Spotify config file Mar 07 23:02:18 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:18 volumio volumio[5309]: info: [squeezelite_mc] Starting proxy server... Mar 07 23:02:18 volumio volumio[5309]: info: Loading i18n strings for locale en Mar 07 23:02:18 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 07 23:02:18 volumio volumio[5309]: info: Volumio Calling Home Mar 07 23:02:18 volumio volumio[5309]: info: [squeezelite_mc] Proxy server started on port 38233 Mar 07 23:02:18 volumio sudo[5458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Mar 07 23:02:18 volumio sudo[5458]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:18 volumio dhcpcd[1579]: eth0: leased 192.168.1.146 for 25200 seconds Mar 07 23:02:18 volumio sudo[5461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Mar 07 23:02:18 volumio sudo[5461]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:18 volumio sudo[5463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 07 23:02:18 volumio sudo[5458]: pam_unix(sudo:session): session closed for user root Mar 07 23:02:18 volumio sudo[5463]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 07 23:02:18 volumio volumio[5309]: info: CoreCommandRouter::volumioRetrievevolume Mar 07 23:02:18 volumio volumio[5309]: info: CoreStateMachine::pushState Mar 07 23:02:18 volumio volumio[5309]: info: CorePlayQueue::getTrack 0 Mar 07 23:02:18 volumio volumio[5309]: info: CoreCommandRouter::volumioPushState Mar 07 23:02:18 volumio systemd[1]: Reloading. Mar 07 23:02:18 volumio volumio[5309]: info: [squeezelite_mc] Server discovery started Mar 07 23:02:18 volumio volumio[5309]: info: [squeezelite_mc] Player finder started Mar 07 23:02:18 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:18 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 07 23:02:18 volumio volumio[5309]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 07 23:02:18 volumio volumio[5309]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Mar 07 23:02:18 volumio volumio[5309]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 23:02:18 volumio volumio[5309]: Error: send ENETUNREACH 255.255.255.255:3483 Mar 07 23:02:18 volumio volumio[5309]: at doSend (dgram.js:692:16) Mar 07 23:02:18 volumio volumio[5309]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Mar 07 23:02:18 volumio volumio[5309]: at afterDns (dgram.js:638:5) Mar 07 23:02:18 volumio volumio[5309]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Mar 07 23:02:18 volumio volumio[5309]: errno: -101, Mar 07 23:02:18 volumio volumio[5309]: code: 'ENETUNREACH', Mar 07 23:02:18 volumio volumio[5309]: syscall: 'send', Mar 07 23:02:18 volumio volumio[5309]: address: '255.255.255.255', Mar 07 23:02:18 volumio volumio[5309]: port: 3483 Mar 07 23:02:18 volumio volumio[5309]: } Mar 07 23:02:18 volumio volumio[5309]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 07 23:02:18 volumio dhcpcd[1579]: eth0: adding route to 192.168.1.0/24 Mar 07 23:02:18 volumio dhcpcd[1579]: eth0: adding default route via 192.168.1.1 Mar 07 23:02:18 volumio avahi-daemon[805]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.146. Mar 07 23:02:18 volumio avahi-daemon[805]: New relevant interface eth0.IPv4 for mDNS. Mar 07 23:02:18 volumio avahi-daemon[805]: Registering new address record for 192.168.1.146 on eth0.IPv4. Mar 07 23:02:18 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 07 23:02:18 volumio mpd[5434]: Mar 07 23:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 07 23:02:18 volumio sudo[5514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-07 23:01 Mar 07 23:02:18 volumio sudo[5514]: 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="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"