-- Logs begin at Thu 2025-01-16 23:49:36 EST, end at Sat 2025-01-18 03:17:58 EST. -- Jan 18 03:16:00 volumio-bedroom kernel: hwmon hwmon1: Undervoltage detected! Jan 18 03:16:00 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:00] [connect] Successful connection Jan 18 03:16:01 volumio-bedroom sudo[14263]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:01 volumio-bedroom sudo[14281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 03:16:01 volumio-bedroom sudo[14281]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:01 volumio-bedroom sudo[14283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 03:16:01 volumio-bedroom sudo[14283]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:01 volumio-bedroom sudo[14283]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:01 volumio-bedroom sudo[14281]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:01 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:01] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737188160 101 Jan 18 03:16:01 volumio-bedroom volumio[14141]: 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: 1 Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: Reloading queue from file Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: Setting Device type: Raspberry PI Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreStateMachine::setRepeat null single undefined Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreStateMachine::pushState Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreStateMachine::setRandom null Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreStateMachine::pushState Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: Completed loading Core Plugins Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: Preparing to generate the ALSA configuration file Jan 18 03:16:01 volumio-bedroom sudo[14293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 18 03:16:01 volumio-bedroom sudo[14293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: Asound.conf file unchanged, so no further update is needed Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: Output device has changed, restarting MPD Jan 18 03:16:01 volumio-bedroom sudo[14293]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: ___________ START PLUGINS ___________ Jan 18 03:16:01 volumio-bedroom sudo[14296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:01 volumio-bedroom sudo[14296]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:01 volumio-bedroom sudo[14296]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: ControllerMpd::onStart: Initializing MPD Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: Creating MPD Configuration file Jan 18 03:16:01 volumio-bedroom sudo[14298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:01 volumio-bedroom sudo[14298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: [1737188161621] CoreMusicLibrary::Adding element Media Servers Jan 18 03:16:01 volumio-bedroom sudo[14302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:01 volumio-bedroom sudo[14302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:01 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Jan 18 03:16:01 volumio-bedroom sudo[14302]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:01 volumio-bedroom sudo[14304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:01 volumio-bedroom sudo[14304]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: [1737188161693] CoreMusicLibrary::Adding element Last_100 Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: [1737188161703] CoreMusicLibrary::Adding element Webradio Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: Initializing BBC Radios Jan 18 03:16:01 volumio-bedroom volumio[14141]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: [squeezelite_mc] Starting proxy server... Jan 18 03:16:01 volumio-bedroom volumio[14141]: info: Volumio Calling Home Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: [squeezelite_mc] Proxy server started on port 35295 Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: CoreStateMachine::pushState Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: [squeezelite_mc] Server discovery started Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: [squeezelite_mc] Player finder started Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:02 volumio-bedroom volumio[14141]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 18 03:16:02 volumio-bedroom volumio[14141]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:02 volumio-bedroom volumio[14141]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 18 03:16:02 volumio-bedroom volumio[14141]: at doSend (dgram.js:692:16) Jan 18 03:16:02 volumio-bedroom volumio[14141]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Jan 18 03:16:02 volumio-bedroom volumio[14141]: at afterDns (dgram.js:638:5) Jan 18 03:16:02 volumio-bedroom volumio[14141]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Jan 18 03:16:02 volumio-bedroom volumio[14141]: errno: -101, Jan 18 03:16:02 volumio-bedroom volumio[14141]: code: 'ENETUNREACH', Jan 18 03:16:02 volumio-bedroom volumio[14141]: syscall: 'send', Jan 18 03:16:02 volumio-bedroom volumio[14141]: address: '255.255.255.255', Jan 18 03:16:02 volumio-bedroom volumio[14141]: port: 3483 Jan 18 03:16:02 volumio-bedroom volumio[14141]: } Jan 18 03:16:02 volumio-bedroom volumio[14141]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:16:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:16:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:16:02 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:16:03 volumio-bedroom sudo[14331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 03:15 Jan 18 03:16:03 volumio-bedroom sudo[14331]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:03 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:16:03 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:16:03 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:16:03 volumio-bedroom sudo[14331]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:03 volumio-bedroom sudo[14333]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 03:16:03 volumio-bedroom sudo[14333]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:03 volumio-bedroom sudo[14333]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:03 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:03] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 18 03:16:03 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:03] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 18 03:16:03 volumio-bedroom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 03:16:03 volumio-bedroom sudo[14298]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:03 volumio-bedroom sudo[14304]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:03 volumio-bedroom systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 18 03:16:03 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:16:03 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:16:03 volumio-bedroom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 03:16:03 volumio-bedroom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jan 18 03:16:03 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:16:03 volumio-bedroom systemd[1]: Stopped Volumio Backend Module. Jan 18 03:16:03 volumio-bedroom systemd[1]: Started Volumio Backend Module. Jan 18 03:16:03 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:16:05 volumio-bedroom systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 18 03:16:05 volumio-bedroom systemd[1]: mpd.service: Failed with result 'protocol'. Jan 18 03:16:05 volumio-bedroom systemd[1]: Failed to start Music Player Daemon. Jan 18 03:16:06 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:16:06 volumio-bedroom sudo[14365]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 03:16:06 volumio-bedroom sudo[14365]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:06 volumio-bedroom sudo[14365]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:07 volumio-bedroom volumio[14350]: info: ------------------------------------------- Jan 18 03:16:07 volumio-bedroom volumio[14350]: info: ----- Volumio3 ---- Jan 18 03:16:07 volumio-bedroom volumio[14350]: info: ------------------------------------------- Jan 18 03:16:07 volumio-bedroom volumio[14350]: info: ----- System startup ---- Jan 18 03:16:07 volumio-bedroom volumio[14350]: info: ------------------------------------------- Jan 18 03:16:08 volumio-bedroom mpd[14368]: Jan 18 03:16 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 03:16:08 volumio-bedroom systemd[1]: Started Music Player Daemon. Jan 18 03:16:08 volumio-bedroom mpd_monitor.sh[524]: MPD restarted due to no mpc output. Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: MYVOLUMIO Environment detected Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Plugin folders cleanup Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning into folder /volumio/app/plugins/ Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning category audio_interface Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning category miscellanea Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning category music_service Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning category plugins.json Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning category system_controller Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning category user_interface Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning into folder /data/plugins/ Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning category music_service Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Scanning category user_interface Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Plugin folders cleanup completed Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: ------------------------------------------- Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: ----- Core plugins startup ---- Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: ------------------------------------------- Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Loading plugins from folder /volumio/app/plugins/ Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Adding plugin upnp to MyMusic Plugins Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Loading plugins from folder /data/plugins/ Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Loading plugin "system"... Jan 18 03:16:08 volumio-bedroom volumio[14350]: info: Loading plugin "appearance"... Jan 18 03:16:08 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:08] [connect] Successful connection Jan 18 03:16:09 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Loading plugin "network"... Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Refreshing Cached IP Addresses Jan 18 03:16:09 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:16:09 volumio-bedroom sudo[14386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 03:16:09 volumio-bedroom sudo[14386]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:09 volumio-bedroom sudo[14388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 03:16:09 volumio-bedroom sudo[14388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:09 volumio-bedroom sudo[14388]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Loading plugin "services"... Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Loading plugin "alsa_controller"... Jan 18 03:16:09 volumio-bedroom sudo[14398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 18 03:16:09 volumio-bedroom sudo[14398]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:09 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:16:09 volumio-bedroom sudo[14386]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Loading plugin "wizard"... Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Loading plugin "networkfs"... Jan 18 03:16:09 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Starting Udev Watcher for removable devices Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Ignoring mount for partition: boot Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Ignoring mount for partition: volumio Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Ignoring mount for partition: volumio_data Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Loading plugin "volumio_command_line_client"... Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Loading plugin "upnp"... Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: [1737188169639] Starting Upmpd Daemon Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Loading plugin "my_music"... Jan 18 03:16:09 volumio-bedroom volumio[14350]: info: Loading plugin "mpd"... Jan 18 03:16:10 volumio-bedroom volumio[14350]: info: Loading plugin "upnp_browser"... Jan 18 03:16:10 volumio-bedroom volumio[14350]: info: Loading plugin "alarm-clock"... Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: Plugin airplay_emulation is not enabled Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: Loading plugin "last_100"... Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: Loading plugin "webradio"... Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: Loading plugin "i2s_dacs"... Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: I2S DAC not set, start Auto-detection Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: Loading plugin "volumiodiscovery"... Jan 18 03:16:11 volumio-bedroom volumio[14350]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:11 volumio-bedroom volumio[14350]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:11 volumio-bedroom volumio[14350]: *** WARNING *** For more information see Jan 18 03:16:11 volumio-bedroom volumio[14350]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:11 volumio-bedroom node[14350]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:11 volumio-bedroom volumio[14350]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:11 volumio-bedroom volumio[14350]: *** WARNING *** For more information see Jan 18 03:16:11 volumio-bedroom node[14350]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:11 volumio-bedroom node[14350]: *** WARNING *** For more information see Jan 18 03:16:11 volumio-bedroom node[14350]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:11 volumio-bedroom node[14350]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:11 volumio-bedroom node[14350]: *** WARNING *** For more information see Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: Discovery: Started advertising with name: Volumio-Bedroom Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:11 volumio-bedroom volumio[14350]: info: Loading plugin "squeezelite_mc"... Jan 18 03:16:12 volumio-bedroom wpa_supplicant[781]: wlan0: Failed to initiate sched scan Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Loading plugin "outputs"... Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Loading plugin "albumart"... Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Plugin example_plugin is not enabled Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Loading plugin "inputs"... Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Loading plugin "updater_comm"... Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Plugin mpdemulation is not enabled Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Loading plugin "rest_api"... Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Loading plugin "websocket"... Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Starting Socket.io Server version 2.3.0 Jan 18 03:16:13 volumio-bedroom volumio[14350]: info: Loading plugin "Systeminfo"... Jan 18 03:16:13 volumio-bedroom volumio[14350]: Forking 3 albumart workers Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: Loading i18n strings for locale en Jan 18 03:16:14 volumio-bedroom volumio[14350]: Updating browse sources language Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::initPlayerControls Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:14 volumio-bedroom volumio[14350]: Express server listening on port 3000 Jan 18 03:16:14 volumio-bedroom volumio[14350]: [Metrics] WebUI: 8s 314.69ms Jan 18 03:16:14 volumio-bedroom sudo[14398]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreStateMachine::resetVolumioState Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreStateMachine::getcurrentVolume Jan 18 03:16:14 volumio-bedroom volumio[14350]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreStateMachine::pushState Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: Volumio Network Manager: Network status updated: 0 Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: Reloading queue from file Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreStateMachine::setRepeat null single undefined Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreStateMachine::pushState Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreStateMachine::setRandom null Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreStateMachine::pushState Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: Setting Device type: Raspberry PI Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: Completed loading Core Plugins Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: Preparing to generate the ALSA configuration file Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: Asound.conf file unchanged, so no further update is needed Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: Output device has changed, restarting MPD Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: ___________ START PLUGINS ___________ Jan 18 03:16:15 volumio-bedroom sudo[14451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:15 volumio-bedroom sudo[14451]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:15 volumio-bedroom sudo[14451]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: ControllerMpd::onStart: Initializing MPD Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: Creating MPD Configuration file Jan 18 03:16:15 volumio-bedroom sudo[14453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:15 volumio-bedroom sudo[14453]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: [1737188175783] CoreMusicLibrary::Adding element Media Servers Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:15 volumio-bedroom sudo[14457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:15 volumio-bedroom sudo[14457]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:15 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Jan 18 03:16:15 volumio-bedroom sudo[14459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:15 volumio-bedroom sudo[14459]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:15 volumio-bedroom sudo[14457]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:15 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: [1737188175857] CoreMusicLibrary::Adding element Last_100 Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:15 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: [1737188175893] CoreMusicLibrary::Adding element Webradio Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: Initializing BBC Radios Jan 18 03:16:15 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:16:15 volumio-bedroom volumio[14350]: Starting albumart workers Jan 18 03:16:15 volumio-bedroom volumio[14350]: Starting albumart workers Jan 18 03:16:15 volumio-bedroom volumio[14350]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jan 18 03:16:15 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:15 volumio-bedroom volumio[14350]: Starting albumart workers Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: [squeezelite_mc] Starting proxy server... Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: Volumio Calling Home Jan 18 03:16:16 volumio-bedroom sudo[14462]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 03:16:16 volumio-bedroom sudo[14462]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:16 volumio-bedroom sudo[14462]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:16 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:16:16 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: [squeezelite_mc] Proxy server started on port 45521 Jan 18 03:16:16 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:16:16 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: CoreStateMachine::pushState Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: [squeezelite_mc] Server discovery started Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: [squeezelite_mc] Player finder started Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:16 volumio-bedroom volumio[14350]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 18 03:16:16 volumio-bedroom volumio[14350]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:17 volumio-bedroom volumio[14350]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 18 03:16:17 volumio-bedroom volumio[14350]: at doSend (dgram.js:692:16) Jan 18 03:16:17 volumio-bedroom volumio[14350]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Jan 18 03:16:17 volumio-bedroom volumio[14350]: at afterDns (dgram.js:638:5) Jan 18 03:16:17 volumio-bedroom volumio[14350]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Jan 18 03:16:17 volumio-bedroom volumio[14350]: errno: -101, Jan 18 03:16:17 volumio-bedroom volumio[14350]: code: 'ENETUNREACH', Jan 18 03:16:17 volumio-bedroom volumio[14350]: syscall: 'send', Jan 18 03:16:17 volumio-bedroom volumio[14350]: address: '255.255.255.255', Jan 18 03:16:17 volumio-bedroom volumio[14350]: port: 3483 Jan 18 03:16:17 volumio-bedroom volumio[14350]: } Jan 18 03:16:17 volumio-bedroom volumio[14350]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:18 volumio-bedroom sudo[14515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 03:15 Jan 18 03:16:18 volumio-bedroom sudo[14515]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:18 volumio-bedroom sudo[14515]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:18 volumio-bedroom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 03:16:18 volumio-bedroom sudo[14453]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:18 volumio-bedroom sudo[14459]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:18 volumio-bedroom systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 18 03:16:19 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:16:19 volumio-bedroom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 03:16:19 volumio-bedroom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jan 18 03:16:19 volumio-bedroom systemd[1]: Stopped Volumio Backend Module. Jan 18 03:16:19 volumio-bedroom systemd[1]: Started Volumio Backend Module. Jan 18 03:16:19 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:16:19 volumio-bedroom mpd[14476]: Jan 18 03:16 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 03:16:19 volumio-bedroom systemd[1]: Started Music Player Daemon. Jan 18 03:16:21 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:21] [info] asio async_connect error: system:111 (Connection refused) Jan 18 03:16:21 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:21] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 18 03:16:21 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:21] [error] handle_connect error: Underlying Transport Error Jan 18 03:16:22 volumio-bedroom volumio[14523]: info: ------------------------------------------- Jan 18 03:16:22 volumio-bedroom volumio[14523]: info: ----- Volumio3 ---- Jan 18 03:16:22 volumio-bedroom volumio[14523]: info: ------------------------------------------- Jan 18 03:16:22 volumio-bedroom volumio[14523]: info: ----- System startup ---- Jan 18 03:16:22 volumio-bedroom volumio[14523]: info: ------------------------------------------- Jan 18 03:16:23 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:16:23 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:16:23 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:16:23 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:16:23 volumio-bedroom volumio[14523]: info: MYVOLUMIO Environment detected Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Plugin folders cleanup Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning into folder /volumio/app/plugins/ Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning category audio_interface Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning category miscellanea Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning category music_service Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning category plugins.json Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning category system_controller Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning category user_interface Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning into folder /data/plugins/ Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning category music_service Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Scanning category user_interface Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Plugin folders cleanup completed Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: ------------------------------------------- Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: ----- Core plugins startup ---- Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: ------------------------------------------- Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Loading plugins from folder /volumio/app/plugins/ Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Adding plugin upnp to MyMusic Plugins Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Loading plugins from folder /data/plugins/ Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Loading plugin "system"... Jan 18 03:16:24 volumio-bedroom volumio[14523]: info: Loading plugin "appearance"... Jan 18 03:16:25 volumio-bedroom kernel: hwmon hwmon1: Voltage normalised Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "network"... Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Refreshing Cached IP Addresses Jan 18 03:16:25 volumio-bedroom sudo[14553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 03:16:25 volumio-bedroom sudo[14553]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:25 volumio-bedroom sudo[14555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 03:16:25 volumio-bedroom sudo[14555]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:25 volumio-bedroom sudo[14555]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:25 volumio-bedroom sudo[14553]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "services"... Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "alsa_controller"... Jan 18 03:16:25 volumio-bedroom sudo[14567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 18 03:16:25 volumio-bedroom sudo[14567]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "wizard"... Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "networkfs"... Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Starting Udev Watcher for removable devices Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Ignoring mount for partition: boot Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Ignoring mount for partition: volumio Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Ignoring mount for partition: volumio_data Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "volumio_command_line_client"... Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "upnp"... Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: [1737188185398] Starting Upmpd Daemon Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "my_music"... Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "mpd"... Jan 18 03:16:25 volumio-bedroom volumio[14523]: info: Loading plugin "upnp_browser"... Jan 18 03:16:26 volumio-bedroom wpa_supplicant[781]: wlan0: Failed to initiate sched scan Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: Loading plugin "alarm-clock"... Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: Plugin airplay_emulation is not enabled Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: Loading plugin "last_100"... Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: Loading plugin "webradio"... Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: Loading plugin "i2s_dacs"... Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: I2S DAC not set, start Auto-detection Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: Loading plugin "volumiodiscovery"... Jan 18 03:16:26 volumio-bedroom volumio[14523]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:26 volumio-bedroom volumio[14523]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:26 volumio-bedroom volumio[14523]: *** WARNING *** For more information see Jan 18 03:16:26 volumio-bedroom volumio[14523]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:26 volumio-bedroom node[14523]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:26 volumio-bedroom volumio[14523]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:26 volumio-bedroom volumio[14523]: *** WARNING *** For more information see Jan 18 03:16:26 volumio-bedroom node[14523]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:26 volumio-bedroom node[14523]: *** WARNING *** For more information see Jan 18 03:16:26 volumio-bedroom node[14523]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:26 volumio-bedroom node[14523]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:26 volumio-bedroom node[14523]: *** WARNING *** For more information see Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: Discovery: Started advertising with name: Volumio-Bedroom Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:26 volumio-bedroom volumio[14523]: info: Loading plugin "squeezelite_mc"... Jan 18 03:16:27 volumio-bedroom kernel: hwmon hwmon1: Undervoltage detected! Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Loading plugin "outputs"... Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Loading plugin "albumart"... Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Plugin example_plugin is not enabled Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Loading plugin "inputs"... Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Loading plugin "updater_comm"... Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Plugin mpdemulation is not enabled Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Loading plugin "rest_api"... Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Loading plugin "websocket"... Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Starting Socket.io Server version 2.3.0 Jan 18 03:16:28 volumio-bedroom volumio[14523]: info: Loading plugin "Systeminfo"... Jan 18 03:16:28 volumio-bedroom sudo[14567]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:29 volumio-bedroom volumio[14523]: Forking 3 albumart workers Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: Loading i18n strings for locale en Jan 18 03:16:29 volumio-bedroom volumio[14523]: Updating browse sources language Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::initPlayerControls Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: Express server listening on port 3000 Jan 18 03:16:29 volumio-bedroom volumio[14523]: [Metrics] WebUI: 8s 340.29ms Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreStateMachine::resetVolumioState Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreStateMachine::getcurrentVolume Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreStateMachine::pushState Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:29 volumio-bedroom volumio[14523]: info: Volumio Network Manager: Network status updated: 0 Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: Reloading queue from file Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: Setting Device type: Raspberry PI Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreStateMachine::setRepeat null single undefined Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreStateMachine::pushState Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreStateMachine::setRandom null Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreStateMachine::pushState Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: Completed loading Core Plugins Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: Preparing to generate the ALSA configuration file Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: Asound.conf file unchanged, so no further update is needed Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: Output device has changed, restarting MPD Jan 18 03:16:30 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: ___________ START PLUGINS ___________ Jan 18 03:16:30 volumio-bedroom sudo[14660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:30 volumio-bedroom sudo[14660]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: ControllerMpd::onStart: Initializing MPD Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: Creating MPD Configuration file Jan 18 03:16:30 volumio-bedroom sudo[14660]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:30 volumio-bedroom sudo[14662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:30 volumio-bedroom sudo[14662]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:30 volumio-bedroom volumio[14523]: Starting albumart workers Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:30 volumio-bedroom volumio[14523]: Starting albumart workers Jan 18 03:16:30 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Jan 18 03:16:30 volumio-bedroom sudo[14666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:30 volumio-bedroom sudo[14666]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: [1737188190243] CoreMusicLibrary::Adding element Media Servers Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:30 volumio-bedroom sudo[14666]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:30 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:30 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: [1737188190272] CoreMusicLibrary::Adding element Last_100 Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:30 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: [1737188190286] CoreMusicLibrary::Adding element Webradio Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:30 volumio-bedroom sudo[14668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:30 volumio-bedroom sudo[14668]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: Initializing BBC Radios Jan 18 03:16:30 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:16:30 volumio-bedroom volumio[14523]: Starting albumart workers Jan 18 03:16:30 volumio-bedroom volumio[14523]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:30 volumio-bedroom systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 18 03:16:30 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:16:30 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:16:30 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:16:30 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:30 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:16:30 volumio-bedroom sudo[14674]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 03:16:30 volumio-bedroom sudo[14674]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: [squeezelite_mc] Starting proxy server... Jan 18 03:16:30 volumio-bedroom sudo[14674]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: Volumio Calling Home Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: [squeezelite_mc] Proxy server started on port 45711 Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreStateMachine::pushState Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: [squeezelite_mc] Server discovery started Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: [squeezelite_mc] Player finder started Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:30 volumio-bedroom volumio[14523]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 18 03:16:30 volumio-bedroom volumio[14523]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:30 volumio-bedroom volumio[14523]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 18 03:16:30 volumio-bedroom volumio[14523]: at doSend (dgram.js:692:16) Jan 18 03:16:30 volumio-bedroom volumio[14523]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Jan 18 03:16:30 volumio-bedroom volumio[14523]: at afterDns (dgram.js:638:5) Jan 18 03:16:30 volumio-bedroom volumio[14523]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Jan 18 03:16:30 volumio-bedroom volumio[14523]: errno: -101, Jan 18 03:16:30 volumio-bedroom volumio[14523]: code: 'ENETUNREACH', Jan 18 03:16:30 volumio-bedroom volumio[14523]: syscall: 'send', Jan 18 03:16:30 volumio-bedroom volumio[14523]: address: '255.255.255.255', Jan 18 03:16:30 volumio-bedroom volumio[14523]: port: 3483 Jan 18 03:16:30 volumio-bedroom volumio[14523]: } Jan 18 03:16:30 volumio-bedroom volumio[14523]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:31 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:31] [connect] Successful connection Jan 18 03:16:31 volumio-bedroom sudo[14723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 03:15 Jan 18 03:16:31 volumio-bedroom sudo[14723]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:31 volumio-bedroom sudo[14723]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:31 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:31] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jan 18 03:16:31 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:31] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Jan 18 03:16:31 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:31] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 18 03:16:31 volumio-bedroom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 03:16:31 volumio-bedroom sudo[14668]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:31 volumio-bedroom sudo[14662]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:31 volumio-bedroom systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 18 03:16:31 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:16:31 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:16:32 volumio-bedroom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 03:16:32 volumio-bedroom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Jan 18 03:16:32 volumio-bedroom systemd[1]: Stopped Volumio Backend Module. Jan 18 03:16:32 volumio-bedroom systemd[1]: Started Volumio Backend Module. Jan 18 03:16:32 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:16:32 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:16:32 volumio-bedroom mpd[14684]: Jan 18 03:16 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 03:16:32 volumio-bedroom systemd[1]: Started Music Player Daemon. Jan 18 03:16:33 volumio-bedroom kernel: hwmon hwmon1: Voltage normalised Jan 18 03:16:34 volumio-bedroom volumio[14736]: info: ------------------------------------------- Jan 18 03:16:34 volumio-bedroom volumio[14736]: info: ----- Volumio3 ---- Jan 18 03:16:34 volumio-bedroom volumio[14736]: info: ------------------------------------------- Jan 18 03:16:34 volumio-bedroom volumio[14736]: info: ----- System startup ---- Jan 18 03:16:34 volumio-bedroom volumio[14736]: info: ------------------------------------------- Jan 18 03:16:35 volumio-bedroom kernel: hwmon hwmon1: Undervoltage detected! Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: MYVOLUMIO Environment detected Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Plugin folders cleanup Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning into folder /volumio/app/plugins/ Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning category audio_interface Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning category miscellanea Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning category music_service Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning category plugins.json Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning category system_controller Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning category user_interface Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning into folder /data/plugins/ Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning category music_service Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Scanning category user_interface Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Plugin folders cleanup completed Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: ------------------------------------------- Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: ----- Core plugins startup ---- Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: ------------------------------------------- Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Loading plugins from folder /volumio/app/plugins/ Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Adding plugin upnp to MyMusic Plugins Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Loading plugins from folder /data/plugins/ Jan 18 03:16:35 volumio-bedroom volumio[14736]: info: Loading plugin "system"... Jan 18 03:16:36 volumio-bedroom volumio[14736]: info: Loading plugin "appearance"... Jan 18 03:16:37 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:16:37 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "network"... Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Refreshing Cached IP Addresses Jan 18 03:16:37 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "services"... Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "alsa_controller"... Jan 18 03:16:37 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "wizard"... Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "networkfs"... Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Starting Udev Watcher for removable devices Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Ignoring mount for partition: boot Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Ignoring mount for partition: volumio Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Ignoring mount for partition: volumio_data Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "volumio_command_line_client"... Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "upnp"... Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: [1737188197463] Starting Upmpd Daemon Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "my_music"... Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "mpd"... Jan 18 03:16:37 volumio-bedroom volumio[14736]: info: Loading plugin "upnp_browser"... Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: Loading plugin "alarm-clock"... Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: Plugin airplay_emulation is not enabled Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: Loading plugin "last_100"... Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: Loading plugin "webradio"... Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: Loading plugin "i2s_dacs"... Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: I2S DAC not set, start Auto-detection Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: Loading plugin "volumiodiscovery"... Jan 18 03:16:38 volumio-bedroom volumio[14736]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:38 volumio-bedroom volumio[14736]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:38 volumio-bedroom volumio[14736]: *** WARNING *** For more information see Jan 18 03:16:38 volumio-bedroom volumio[14736]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:38 volumio-bedroom node[14736]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:38 volumio-bedroom volumio[14736]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:38 volumio-bedroom volumio[14736]: *** WARNING *** For more information see Jan 18 03:16:38 volumio-bedroom node[14736]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:38 volumio-bedroom node[14736]: *** WARNING *** For more information see Jan 18 03:16:38 volumio-bedroom node[14736]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:38 volumio-bedroom node[14736]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:38 volumio-bedroom node[14736]: *** WARNING *** For more information see Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: Discovery: Started advertising with name: Volumio-Bedroom Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:38 volumio-bedroom volumio[14736]: info: Loading plugin "squeezelite_mc"... Jan 18 03:16:39 volumio-bedroom wpa_supplicant[781]: wlan0: Failed to initiate sched scan Jan 18 03:16:39 volumio-bedroom sudo[14766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 03:16:39 volumio-bedroom sudo[14768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 03:16:39 volumio-bedroom sudo[14766]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:39 volumio-bedroom sudo[14768]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:40 volumio-bedroom sudo[14775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 18 03:16:40 volumio-bedroom sudo[14775]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:40 volumio-bedroom sudo[14768]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:40 volumio-bedroom sudo[14766]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Loading plugin "outputs"... Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Loading plugin "albumart"... Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Plugin example_plugin is not enabled Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Loading plugin "inputs"... Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Loading plugin "updater_comm"... Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Plugin mpdemulation is not enabled Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Loading plugin "rest_api"... Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Loading plugin "websocket"... Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Starting Socket.io Server version 2.3.0 Jan 18 03:16:40 volumio-bedroom volumio[14736]: info: Loading plugin "Systeminfo"... Jan 18 03:16:41 volumio-bedroom volumio[14736]: Forking 3 albumart workers Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: Loading i18n strings for locale en Jan 18 03:16:41 volumio-bedroom volumio[14736]: Updating browse sources language Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:41 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:41] [connect] Successful connection Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::initPlayerControls Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:41 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:41 volumio-bedroom volumio[14736]: Express server listening on port 3000 Jan 18 03:16:41 volumio-bedroom volumio[14736]: [Metrics] WebUI: 8s 610.72ms Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreStateMachine::resetVolumioState Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreStateMachine::getcurrentVolume Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreStateMachine::pushState Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Volumio Network Manager: Network status updated: 0 Jan 18 03:16:42 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:42] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737188201 101 Jan 18 03:16:42 volumio-bedroom volumio[14736]: 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: 1 Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Reloading queue from file Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Setting Device type: Raspberry PI Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreStateMachine::setRepeat null single undefined Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreStateMachine::pushState Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreStateMachine::setRandom null Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreStateMachine::pushState Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:42 volumio-bedroom volumio[14736]: Starting albumart workers Jan 18 03:16:42 volumio-bedroom volumio[14736]: Starting albumart workers Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Completed loading Core Plugins Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Preparing to generate the ALSA configuration file Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Asound.conf file unchanged, so no further update is needed Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Output device has changed, restarting MPD Jan 18 03:16:42 volumio-bedroom sudo[14834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:42 volumio-bedroom sudo[14834]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: ___________ START PLUGINS ___________ Jan 18 03:16:42 volumio-bedroom sudo[14834]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: ControllerMpd::onStart: Initializing MPD Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Creating MPD Configuration file Jan 18 03:16:42 volumio-bedroom sudo[14837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:42 volumio-bedroom sudo[14837]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:42 volumio-bedroom sudo[14840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:42 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Jan 18 03:16:42 volumio-bedroom sudo[14840]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: [1737188202475] CoreMusicLibrary::Adding element Media Servers Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:42 volumio-bedroom sudo[14840]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:42 volumio-bedroom sudo[14843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:42 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:16:42 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:16:42 volumio-bedroom sudo[14843]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: [1737188202515] CoreMusicLibrary::Adding element Last_100 Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: [1737188202519] CoreMusicLibrary::Adding element Webradio Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Initializing BBC Radios Jan 18 03:16:42 volumio-bedroom volumio[14736]: Starting albumart workers Jan 18 03:16:42 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:16:42 volumio-bedroom systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 18 03:16:42 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:16:42 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:16:42 volumio-bedroom volumio[14736]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:42 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:16:42 volumio-bedroom sudo[14848]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 03:16:42 volumio-bedroom sudo[14848]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:42 volumio-bedroom sudo[14848]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: [squeezelite_mc] Starting proxy server... Jan 18 03:16:42 volumio-bedroom volumio[14736]: info: Volumio Calling Home Jan 18 03:16:42 volumio-bedroom sudo[14775]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: [squeezelite_mc] Proxy server started on port 38129 Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: CoreStateMachine::pushState Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: [squeezelite_mc] Server discovery started Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: [squeezelite_mc] Player finder started Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:43 volumio-bedroom volumio[14736]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 18 03:16:43 volumio-bedroom volumio[14736]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:43 volumio-bedroom volumio[14736]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 18 03:16:43 volumio-bedroom volumio[14736]: at doSend (dgram.js:692:16) Jan 18 03:16:43 volumio-bedroom volumio[14736]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Jan 18 03:16:43 volumio-bedroom volumio[14736]: at afterDns (dgram.js:638:5) Jan 18 03:16:43 volumio-bedroom volumio[14736]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Jan 18 03:16:43 volumio-bedroom volumio[14736]: errno: -101, Jan 18 03:16:43 volumio-bedroom volumio[14736]: code: 'ENETUNREACH', Jan 18 03:16:43 volumio-bedroom volumio[14736]: syscall: 'send', Jan 18 03:16:43 volumio-bedroom volumio[14736]: address: '255.255.255.255', Jan 18 03:16:43 volumio-bedroom volumio[14736]: port: 3483 Jan 18 03:16:43 volumio-bedroom volumio[14736]: } Jan 18 03:16:43 volumio-bedroom volumio[14736]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:43 volumio-bedroom kernel: hwmon hwmon1: Voltage normalised Jan 18 03:16:43 volumio-bedroom sudo[14899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 03:15 Jan 18 03:16:43 volumio-bedroom sudo[14899]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:43 volumio-bedroom sudo[14899]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:44 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:44] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 18 03:16:44 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:44] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 18 03:16:44 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:16:44 volumio-bedroom sudo[14843]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:44 volumio-bedroom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 03:16:44 volumio-bedroom sudo[14837]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:44 volumio-bedroom systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 18 03:16:44 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:16:44 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:16:44 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:16:44 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:16:44 volumio-bedroom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 03:16:44 volumio-bedroom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. Jan 18 03:16:44 volumio-bedroom systemd[1]: Stopped Volumio Backend Module. Jan 18 03:16:44 volumio-bedroom mpd[14859]: Jan 18 03:16 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 03:16:44 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:16:44 volumio-bedroom systemd[1]: Started Volumio Backend Module. Jan 18 03:16:44 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:16:44 volumio-bedroom systemd[1]: Started Music Player Daemon. Jan 18 03:16:44 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:16:46 volumio-bedroom volumio[14912]: info: ------------------------------------------- Jan 18 03:16:46 volumio-bedroom volumio[14912]: info: ----- Volumio3 ---- Jan 18 03:16:46 volumio-bedroom volumio[14912]: info: ------------------------------------------- Jan 18 03:16:46 volumio-bedroom volumio[14912]: info: ----- System startup ---- Jan 18 03:16:46 volumio-bedroom volumio[14912]: info: ------------------------------------------- Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: MYVOLUMIO Environment detected Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Plugin folders cleanup Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning into folder /volumio/app/plugins/ Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning category audio_interface Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning category miscellanea Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning category music_service Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning category plugins.json Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning category system_controller Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning category user_interface Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning into folder /data/plugins/ Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning category music_service Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Scanning category user_interface Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Plugin folders cleanup completed Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: ------------------------------------------- Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: ----- Core plugins startup ---- Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: ------------------------------------------- Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Loading plugins from folder /volumio/app/plugins/ Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Adding plugin upnp to MyMusic Plugins Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Loading plugins from folder /data/plugins/ Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Loading plugin "system"... Jan 18 03:16:47 volumio-bedroom volumio[14912]: info: Loading plugin "appearance"... Jan 18 03:16:47 volumio-bedroom kernel: hwmon hwmon1: Undervoltage detected! Jan 18 03:16:49 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:16:49] [connect] Successful connection Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Loading plugin "network"... Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Refreshing Cached IP Addresses Jan 18 03:16:49 volumio-bedroom sudo[14943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 03:16:49 volumio-bedroom sudo[14943]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:49 volumio-bedroom sudo[14945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 03:16:49 volumio-bedroom sudo[14945]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:49 volumio-bedroom sudo[14943]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Loading plugin "services"... Jan 18 03:16:49 volumio-bedroom sudo[14945]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Loading plugin "alsa_controller"... Jan 18 03:16:49 volumio-bedroom sudo[14956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 18 03:16:49 volumio-bedroom sudo[14956]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:49 volumio-bedroom sudo[14956]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Loading plugin "wizard"... Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Loading plugin "networkfs"... Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Starting Udev Watcher for removable devices Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Ignoring mount for partition: boot Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Ignoring mount for partition: volumio Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Ignoring mount for partition: volumio_data Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Loading plugin "volumio_command_line_client"... Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Loading plugin "upnp"... Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: [1737188209655] Starting Upmpd Daemon Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Loading plugin "my_music"... Jan 18 03:16:49 volumio-bedroom volumio[14912]: info: Loading plugin "mpd"... Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: Loading plugin "upnp_browser"... Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: Loading plugin "alarm-clock"... Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: Plugin airplay_emulation is not enabled Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: Loading plugin "last_100"... Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: Loading plugin "webradio"... Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: Loading plugin "i2s_dacs"... Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: I2S DAC not set, start Auto-detection Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: Loading plugin "volumiodiscovery"... Jan 18 03:16:50 volumio-bedroom volumio[14912]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:50 volumio-bedroom volumio[14912]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:50 volumio-bedroom volumio[14912]: *** WARNING *** For more information see Jan 18 03:16:50 volumio-bedroom volumio[14912]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:50 volumio-bedroom node[14912]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:50 volumio-bedroom volumio[14912]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:50 volumio-bedroom volumio[14912]: *** WARNING *** For more information see Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 18 03:16:50 volumio-bedroom node[14912]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:50 volumio-bedroom node[14912]: *** WARNING *** For more information see Jan 18 03:16:50 volumio-bedroom node[14912]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:16:50 volumio-bedroom node[14912]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:16:50 volumio-bedroom node[14912]: *** WARNING *** For more information see Jan 18 03:16:50 volumio-bedroom volumio[14912]: info: Discovery: Started advertising with name: Volumio-Bedroom Jan 18 03:16:51 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:16:51 volumio-bedroom volumio[14912]: info: Loading plugin "squeezelite_mc"... Jan 18 03:16:51 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:16:51 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:16:51 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:16:51 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:16:52 volumio-bedroom volumio[14912]: info: Loading plugin "outputs"... Jan 18 03:16:52 volumio-bedroom volumio[14912]: info: Loading plugin "albumart"... Jan 18 03:16:52 volumio-bedroom volumio[14912]: info: Plugin example_plugin is not enabled Jan 18 03:16:52 volumio-bedroom volumio[14912]: info: Loading plugin "inputs"... Jan 18 03:16:52 volumio-bedroom volumio[14912]: info: Loading plugin "updater_comm"... Jan 18 03:16:53 volumio-bedroom volumio[14912]: info: Plugin mpdemulation is not enabled Jan 18 03:16:53 volumio-bedroom volumio[14912]: info: Loading plugin "rest_api"... Jan 18 03:16:53 volumio-bedroom volumio[14912]: info: Loading plugin "websocket"... Jan 18 03:16:53 volumio-bedroom volumio[14912]: info: Starting Socket.io Server version 2.3.0 Jan 18 03:16:53 volumio-bedroom volumio[14912]: info: Loading plugin "Systeminfo"... Jan 18 03:16:53 volumio-bedroom volumio[14912]: Forking 3 albumart workers Jan 18 03:16:53 volumio-bedroom wpa_supplicant[781]: wlan0: Failed to initiate sched scan Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: Loading i18n strings for locale en Jan 18 03:16:54 volumio-bedroom volumio[14912]: Updating browse sources language Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::initPlayerControls Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: Express server listening on port 3000 Jan 18 03:16:54 volumio-bedroom volumio[14912]: [Metrics] WebUI: 8s 954.20ms Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreStateMachine::resetVolumioState Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreStateMachine::getcurrentVolume Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreStateMachine::pushState Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: Volumio Network Manager: Network status updated: 0 Jan 18 03:16:54 volumio-bedroom volumio[14912]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jan 18 03:16:54 volumio-bedroom volumio[14912]: wlan0 Interface doesn't support scanning : Device or resource busy Jan 18 03:16:54 volumio-bedroom volumio[14912]: info: Cannot use regular scanning, forcing with ap-force Jan 18 03:16:54 volumio-bedroom sudo[15008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jan 18 03:16:54 volumio-bedroom sudo[15008]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:55 volumio-bedroom volumio[14912]: Starting albumart workers Jan 18 03:16:55 volumio-bedroom volumio[14912]: Starting albumart workers Jan 18 03:16:55 volumio-bedroom volumio[14912]: Starting albumart workers Jan 18 03:16:57 volumio-bedroom sudo[15008]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: Reloading queue from file Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: CoreStateMachine::setRepeat null single undefined Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: CoreStateMachine::pushState Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: CoreStateMachine::setRandom null Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: CoreStateMachine::pushState Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: Setting Device type: Raspberry PI Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: Completed loading Core Plugins Jan 18 03:16:57 volumio-bedroom volumio[14912]: info: Preparing to generate the ALSA configuration file Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: Asound.conf file unchanged, so no further update is needed Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: Output device has changed, restarting MPD Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: ___________ START PLUGINS ___________ Jan 18 03:16:58 volumio-bedroom sudo[15039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:58 volumio-bedroom sudo[15039]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: ControllerMpd::onStart: Initializing MPD Jan 18 03:16:58 volumio-bedroom sudo[15039]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: Creating MPD Configuration file Jan 18 03:16:58 volumio-bedroom sudo[15041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:58 volumio-bedroom sudo[15041]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:58 volumio-bedroom sudo[15045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:58 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: [1737188218184] CoreMusicLibrary::Adding element Media Servers Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:58 volumio-bedroom sudo[15045]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:58 volumio-bedroom sudo[15045]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:58 volumio-bedroom sudo[15047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:16:58 volumio-bedroom sudo[15047]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:58 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:16:58 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: [1737188218259] CoreMusicLibrary::Adding element Last_100 Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: [1737188218275] CoreMusicLibrary::Adding element Webradio Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: Initializing BBC Radios Jan 18 03:16:58 volumio-bedroom volumio[14912]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:58 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:16:58 volumio-bedroom systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 18 03:16:58 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:16:58 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:16:58 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: [squeezelite_mc] Starting proxy server... Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: Volumio Calling Home Jan 18 03:16:58 volumio-bedroom sudo[15058]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 03:16:58 volumio-bedroom sudo[15058]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:58 volumio-bedroom sudo[15058]: pam_unix(sudo:session): session closed for user root Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: [squeezelite_mc] Proxy server started on port 46231 Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreStateMachine::pushState Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CorePlayQueue::getTrack 0 Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::volumioPushState Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: [squeezelite_mc] Server discovery started Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: [squeezelite_mc] Player finder started Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:16:58 volumio-bedroom volumio[14912]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 18 03:16:58 volumio-bedroom volumio[14912]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:58 volumio-bedroom volumio[14912]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 18 03:16:58 volumio-bedroom volumio[14912]: at doSend (dgram.js:692:16) Jan 18 03:16:58 volumio-bedroom volumio[14912]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Jan 18 03:16:58 volumio-bedroom volumio[14912]: at afterDns (dgram.js:638:5) Jan 18 03:16:58 volumio-bedroom volumio[14912]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Jan 18 03:16:58 volumio-bedroom volumio[14912]: errno: -101, Jan 18 03:16:58 volumio-bedroom volumio[14912]: code: 'ENETUNREACH', Jan 18 03:16:58 volumio-bedroom volumio[14912]: syscall: 'send', Jan 18 03:16:58 volumio-bedroom volumio[14912]: address: '255.255.255.255', Jan 18 03:16:58 volumio-bedroom volumio[14912]: port: 3483 Jan 18 03:16:58 volumio-bedroom volumio[14912]: } Jan 18 03:16:58 volumio-bedroom volumio[14912]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:16:59 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:16:59 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:16:59 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:16:59 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:16:59 volumio-bedroom sudo[15092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 03:15 Jan 18 03:16:59 volumio-bedroom sudo[15092]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:16:59 volumio-bedroom sudo[15092]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:00 volumio-bedroom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 03:17:00 volumio-bedroom sudo[15047]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:00 volumio-bedroom sudo[15041]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:00 volumio-bedroom systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 18 03:17:00 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:17:00 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:17:00 volumio-bedroom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 03:17:00 volumio-bedroom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 6. Jan 18 03:17:00 volumio-bedroom systemd[1]: Stopped Volumio Backend Module. Jan 18 03:17:00 volumio-bedroom systemd[1]: Started Volumio Backend Module. Jan 18 03:17:00 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:17:00 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:17:00 volumio-bedroom mpd[15066]: Jan 18 03:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 03:17:00 volumio-bedroom systemd[1]: Started Music Player Daemon. Jan 18 03:17:01 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:17:01] [connect] Successful connection Jan 18 03:17:02 volumio-bedroom volumio[15107]: info: ------------------------------------------- Jan 18 03:17:02 volumio-bedroom volumio[15107]: info: ----- Volumio3 ---- Jan 18 03:17:02 volumio-bedroom volumio[15107]: info: ------------------------------------------- Jan 18 03:17:02 volumio-bedroom volumio[15107]: info: ----- System startup ---- Jan 18 03:17:02 volumio-bedroom volumio[15107]: info: ------------------------------------------- Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: MYVOLUMIO Environment detected Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Plugin folders cleanup Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning into folder /volumio/app/plugins/ Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning category audio_interface Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning category miscellanea Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning category music_service Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning category plugins.json Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning category system_controller Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning category user_interface Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning into folder /data/plugins/ Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning category music_service Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Scanning category user_interface Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Plugin folders cleanup completed Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: ------------------------------------------- Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: ----- Core plugins startup ---- Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: ------------------------------------------- Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Loading plugins from folder /volumio/app/plugins/ Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Adding plugin upnp to MyMusic Plugins Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Loading plugins from folder /data/plugins/ Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Loading plugin "system"... Jan 18 03:17:03 volumio-bedroom volumio[15107]: info: Loading plugin "appearance"... Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Loading plugin "network"... Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Refreshing Cached IP Addresses Jan 18 03:17:05 volumio-bedroom sudo[15137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 03:17:05 volumio-bedroom sudo[15137]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:05 volumio-bedroom sudo[15139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 03:17:05 volumio-bedroom sudo[15139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:05 volumio-bedroom sudo[15139]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Loading plugin "services"... Jan 18 03:17:05 volumio-bedroom sudo[15137]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Loading plugin "alsa_controller"... Jan 18 03:17:05 volumio-bedroom sudo[15154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 18 03:17:05 volumio-bedroom sudo[15154]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Loading plugin "wizard"... Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Loading plugin "networkfs"... Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Starting Udev Watcher for removable devices Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Ignoring mount for partition: boot Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Ignoring mount for partition: volumio Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Ignoring mount for partition: volumio_data Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Loading plugin "volumio_command_line_client"... Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Loading plugin "upnp"... Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: [1737188225822] Starting Upmpd Daemon Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Loading plugin "my_music"... Jan 18 03:17:05 volumio-bedroom volumio[15107]: info: Loading plugin "mpd"... Jan 18 03:17:05 volumio-bedroom nmbd[638]: [2025/01/18 03:17:05.867612, 0] ../source3/libsmb/nmblib.c:917(send_udp) Jan 18 03:17:05 volumio-bedroom nmbd[638]: Packet send failed to 192.168.3.255(138) ERRNO=Network is unreachable Jan 18 03:17:05 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:17:06 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:17:06 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:17:06 volumio-bedroom volumio[15107]: info: Loading plugin "upnp_browser"... Jan 18 03:17:06 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:17:06 volumio-bedroom volumio[15107]: info: Loading plugin "alarm-clock"... Jan 18 03:17:06 volumio-bedroom volumio[15107]: info: Plugin airplay_emulation is not enabled Jan 18 03:17:06 volumio-bedroom volumio[15107]: info: Loading plugin "last_100"... Jan 18 03:17:06 volumio-bedroom volumio[15107]: info: Loading plugin "webradio"... Jan 18 03:17:06 volumio-bedroom volumio[15107]: info: Loading plugin "i2s_dacs"... Jan 18 03:17:06 volumio-bedroom volumio[15107]: info: I2S DAC not set, start Auto-detection Jan 18 03:17:06 volumio-bedroom volumio[15107]: info: Loading plugin "volumiodiscovery"... Jan 18 03:17:07 volumio-bedroom volumio[15107]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:17:07 volumio-bedroom volumio[15107]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:17:07 volumio-bedroom volumio[15107]: *** WARNING *** For more information see Jan 18 03:17:07 volumio-bedroom node[15107]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:17:07 volumio-bedroom volumio[15107]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:17:07 volumio-bedroom volumio[15107]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:17:07 volumio-bedroom volumio[15107]: *** WARNING *** For more information see Jan 18 03:17:07 volumio-bedroom node[15107]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:17:07 volumio-bedroom node[15107]: *** WARNING *** For more information see Jan 18 03:17:07 volumio-bedroom node[15107]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:17:07 volumio-bedroom node[15107]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:17:07 volumio-bedroom node[15107]: *** WARNING *** For more information see Jan 18 03:17:07 volumio-bedroom volumio[15107]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 18 03:17:07 volumio-bedroom volumio[15107]: info: Discovery: Started advertising with name: Volumio-Bedroom Jan 18 03:17:07 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:17:07 volumio-bedroom volumio[15107]: info: Loading plugin "squeezelite_mc"... Jan 18 03:17:08 volumio-bedroom nmbd[638]: [2025/01/18 03:17:08.681897, 0] ../source3/nmbd/nmbd.c:361(reload_interfaces) Jan 18 03:17:08 volumio-bedroom nmbd[638]: reload_interfaces: No subnets to listen to. Waiting.. Jan 18 03:17:08 volumio-bedroom wpa_supplicant[781]: wlan0: Trying to associate with SSID 'Home' Jan 18 03:17:08 volumio-bedroom volumio[15107]: info: Loading plugin "outputs"... Jan 18 03:17:08 volumio-bedroom volumio[15107]: info: Loading plugin "albumart"... Jan 18 03:17:08 volumio-bedroom volumio[15107]: info: Plugin example_plugin is not enabled Jan 18 03:17:08 volumio-bedroom volumio[15107]: info: Loading plugin "inputs"... Jan 18 03:17:08 volumio-bedroom volumio[15107]: info: Loading plugin "updater_comm"... Jan 18 03:17:08 volumio-bedroom wpa_supplicant[781]: wlan0: Associated with 3a:de:4b:76:33:a4 Jan 18 03:17:08 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-CONNECTED - Connection to 3a:de:4b:76:33:a4 completed [id=0 id_str=] Jan 18 03:17:08 volumio-bedroom dhcpcd[795]: wlan0: carrier acquired Jan 18 03:17:08 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 18 03:17:08 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jan 18 03:17:08 volumio-bedroom dhcpcd[795]: wlan0: IAID eb:35:96:7a Jan 18 03:17:08 volumio-bedroom dhcpcd[795]: wlan0: soliciting an IPv6 router Jan 18 03:17:08 volumio-bedroom sudo[15154]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:09 volumio-bedroom volumio[15107]: info: Plugin mpdemulation is not enabled Jan 18 03:17:09 volumio-bedroom volumio[15107]: info: Loading plugin "rest_api"... Jan 18 03:17:09 volumio-bedroom volumio[15107]: info: Loading plugin "websocket"... Jan 18 03:17:09 volumio-bedroom volumio[15107]: info: Starting Socket.io Server version 2.3.0 Jan 18 03:17:09 volumio-bedroom volumio[15107]: info: Loading plugin "Systeminfo"... Jan 18 03:17:09 volumio-bedroom volumio[15107]: Forking 3 albumart workers Jan 18 03:17:09 volumio-bedroom dhcpcd[795]: wlan0: soliciting a DHCP lease Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: Loading i18n strings for locale en Jan 18 03:17:10 volumio-bedroom volumio[15107]: Updating browse sources language Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::initPlayerControls Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: Express server listening on port 3000 Jan 18 03:17:10 volumio-bedroom volumio[15107]: [Metrics] WebUI: 8s 960.55ms Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreStateMachine::resetVolumioState Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreStateMachine::getcurrentVolume Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreStateMachine::pushState Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CorePlayQueue::getTrack 0 Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::volumioPushState Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:10 volumio-bedroom volumio[15107]: info: Volumio Network Manager: Network status updated: 0 Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: Reloading queue from file Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreStateMachine::setRepeat null single undefined Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreStateMachine::pushState Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CorePlayQueue::getTrack 0 Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::volumioPushState Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreStateMachine::setRandom null Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreStateMachine::pushState Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CorePlayQueue::getTrack 0 Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::volumioPushState Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: Setting Device type: Raspberry PI Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: Completed loading Core Plugins Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: Preparing to generate the ALSA configuration file Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: Asound.conf file unchanged, so no further update is needed Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: Output device has changed, restarting MPD Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: ___________ START PLUGINS ___________ Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: ControllerMpd::onStart: Initializing MPD Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: Creating MPD Configuration file Jan 18 03:17:11 volumio-bedroom sudo[15207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:17:11 volumio-bedroom sudo[15207]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:11 volumio-bedroom sudo[15207]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:11 volumio-bedroom sudo[15209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:17:11 volumio-bedroom sudo[15209]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: [1737188231345] CoreMusicLibrary::Adding element Media Servers Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:17:11 volumio-bedroom sudo[15212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:17:11 volumio-bedroom sudo[15212]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: [1737188231388] CoreMusicLibrary::Adding element Last_100 Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:17:11 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: [1737188231407] CoreMusicLibrary::Adding element Webradio Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:17:11 volumio-bedroom sudo[15212]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: Initializing BBC Radios Jan 18 03:17:11 volumio-bedroom sudo[15215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:17:11 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:17:11 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:17:11 volumio-bedroom sudo[15215]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:11 volumio-bedroom volumio[15107]: Starting albumart workers Jan 18 03:17:11 volumio-bedroom volumio[15107]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:11 volumio-bedroom volumio[15107]: Starting albumart workers Jan 18 03:17:11 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:17:11 volumio-bedroom systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 18 03:17:11 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:17:11 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:17:11 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: [squeezelite_mc] Starting proxy server... Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: Volumio Calling Home Jan 18 03:17:11 volumio-bedroom volumio[15107]: Starting albumart workers Jan 18 03:17:11 volumio-bedroom sudo[15229]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 03:17:11 volumio-bedroom sudo[15229]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:11 volumio-bedroom sudo[15229]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:11 volumio-bedroom volumio[15107]: info: [squeezelite_mc] Proxy server started on port 39557 Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: CoreStateMachine::pushState Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: CorePlayQueue::getTrack 0 Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: CoreCommandRouter::volumioPushState Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: [squeezelite_mc] Server discovery started Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: [squeezelite_mc] Player finder started Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:17:12 volumio-bedroom volumio[15107]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 18 03:17:12 volumio-bedroom volumio[15107]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:17:12 volumio-bedroom volumio[15107]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 18 03:17:12 volumio-bedroom volumio[15107]: at doSend (dgram.js:692:16) Jan 18 03:17:12 volumio-bedroom volumio[15107]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Jan 18 03:17:12 volumio-bedroom volumio[15107]: at afterDns (dgram.js:638:5) Jan 18 03:17:12 volumio-bedroom volumio[15107]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Jan 18 03:17:12 volumio-bedroom volumio[15107]: errno: -101, Jan 18 03:17:12 volumio-bedroom volumio[15107]: code: 'ENETUNREACH', Jan 18 03:17:12 volumio-bedroom volumio[15107]: syscall: 'send', Jan 18 03:17:12 volumio-bedroom volumio[15107]: address: '255.255.255.255', Jan 18 03:17:12 volumio-bedroom volumio[15107]: port: 3483 Jan 18 03:17:12 volumio-bedroom volumio[15107]: } Jan 18 03:17:12 volumio-bedroom volumio[15107]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:17:13 volumio-bedroom sudo[15270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 03:16 Jan 18 03:17:13 volumio-bedroom sudo[15270]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:13 volumio-bedroom sudo[15270]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:14 volumio-bedroom systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 18 03:17:14 volumio-bedroom sudo[15209]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:14 volumio-bedroom sudo[15215]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:14 volumio-bedroom systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 18 03:17:14 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:17:14 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:17:14 volumio-bedroom systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 18 03:17:14 volumio-bedroom systemd[1]: volumio.service: Scheduled restart job, restart counter is at 7. Jan 18 03:17:14 volumio-bedroom systemd[1]: Stopped Volumio Backend Module. Jan 18 03:17:14 volumio-bedroom systemd[1]: Started Volumio Backend Module. Jan 18 03:17:14 volumio-bedroom systemd[1]: Started dynamicswap service. Jan 18 03:17:14 volumio-bedroom systemd[1]: dynamicswap.service: Succeeded. Jan 18 03:17:14 volumio-bedroom dhcpcd[795]: wlan0: probing for an IPv4LL address Jan 18 03:17:15 volumio-bedroom mpd[15234]: Jan 18 03:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 03:17:15 volumio-bedroom systemd[1]: Started Music Player Daemon. Jan 18 03:17:16 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:17:16] [info] asio async_connect error: system:111 (Connection refused) Jan 18 03:17:16 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:17:16] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 18 03:17:16 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:17:16] [error] handle_connect error: Underlying Transport Error Jan 18 03:17:17 volumio-bedroom volumio[15283]: info: ------------------------------------------- Jan 18 03:17:17 volumio-bedroom volumio[15283]: info: ----- Volumio3 ---- Jan 18 03:17:17 volumio-bedroom volumio[15283]: info: ------------------------------------------- Jan 18 03:17:17 volumio-bedroom volumio[15283]: info: ----- System startup ---- Jan 18 03:17:17 volumio-bedroom volumio[15283]: info: ------------------------------------------- Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: MYVOLUMIO Environment detected Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Plugin folders cleanup Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning into folder /volumio/app/plugins/ Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning category audio_interface Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning category miscellanea Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning category music_service Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning category plugins.json Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning category system_controller Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning category user_interface Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning into folder /data/plugins/ Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning category music_service Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Scanning category user_interface Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Plugin folders cleanup completed Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: ------------------------------------------- Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: ----- Core plugins startup ---- Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: ------------------------------------------- Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Loading plugins from folder /volumio/app/plugins/ Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Adding plugin upnp to MyMusic Plugins Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Loading plugins from folder /data/plugins/ Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Loading plugin "system"... Jan 18 03:17:18 volumio-bedroom volumio[15283]: info: Loading plugin "appearance"... Jan 18 03:17:19 volumio-bedroom dhcpcd[795]: wlan0: using IPv4LL address 169.254.250.27 Jan 18 03:17:19 volumio-bedroom avahi-daemon[536]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.250.27. Jan 18 03:17:19 volumio-bedroom dhcpcd[795]: wlan0: adding route to 169.254.0.0/16 Jan 18 03:17:19 volumio-bedroom dhcpcd[795]: wlan0: adding default route Jan 18 03:17:19 volumio-bedroom avahi-daemon[536]: New relevant interface wlan0.IPv4 for mDNS. Jan 18 03:17:19 volumio-bedroom avahi-daemon[536]: Registering new address record for 169.254.250.27 on wlan0.IPv4. Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Loading plugin "network"... Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Refreshing Cached IP Addresses Jan 18 03:17:20 volumio-bedroom sudo[15325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 03:17:20 volumio-bedroom sudo[15325]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:20 volumio-bedroom sudo[15327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 03:17:20 volumio-bedroom sudo[15327]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:20 volumio-bedroom sudo[15327]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Loading plugin "services"... Jan 18 03:17:20 volumio-bedroom sudo[15325]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Loading plugin "alsa_controller"... Jan 18 03:17:20 volumio-bedroom sudo[15339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 18 03:17:20 volumio-bedroom sudo[15339]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Loading plugin "wizard"... Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Loading plugin "networkfs"... Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Starting Udev Watcher for removable devices Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Ignoring mount for partition: boot Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Ignoring mount for partition: volumio Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Ignoring mount for partition: volumio_data Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Loading plugin "volumio_command_line_client"... Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Loading plugin "upnp"... Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: [1737188240784] Starting Upmpd Daemon Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Loading plugin "my_music"... Jan 18 03:17:20 volumio-bedroom volumio[15283]: info: Loading plugin "mpd"... Jan 18 03:17:21 volumio-bedroom ntpd[679]: Listen normally on 4 wlan0 169.254.250.27:123 Jan 18 03:17:21 volumio-bedroom ntpd[679]: new interface(s) found: waking up resolver Jan 18 03:17:21 volumio-bedroom volumio[15283]: info: Loading plugin "upnp_browser"... Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: Loading plugin "alarm-clock"... Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: Plugin airplay_emulation is not enabled Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: Loading plugin "last_100"... Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: Loading plugin "webradio"... Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: Loading plugin "i2s_dacs"... Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: I2S DAC not set, start Auto-detection Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: Loading plugin "volumiodiscovery"... Jan 18 03:17:22 volumio-bedroom volumio[15283]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:17:22 volumio-bedroom volumio[15283]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:17:22 volumio-bedroom volumio[15283]: *** WARNING *** For more information see Jan 18 03:17:22 volumio-bedroom volumio[15283]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:17:22 volumio-bedroom node[15283]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 18 03:17:22 volumio-bedroom volumio[15283]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:17:22 volumio-bedroom volumio[15283]: *** WARNING *** For more information see Jan 18 03:17:22 volumio-bedroom node[15283]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:17:22 volumio-bedroom node[15283]: *** WARNING *** For more information see Jan 18 03:17:22 volumio-bedroom node[15283]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 18 03:17:22 volumio-bedroom node[15283]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 18 03:17:22 volumio-bedroom node[15283]: *** WARNING *** For more information see Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: Discovery: Started advertising with name: Volumio-Bedroom Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 18 03:17:22 volumio-bedroom volumio[15283]: info: Loading plugin "squeezelite_mc"... Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Loading plugin "outputs"... Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Loading plugin "albumart"... Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Plugin example_plugin is not enabled Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Loading plugin "inputs"... Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Loading plugin "updater_comm"... Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Plugin mpdemulation is not enabled Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Loading plugin "rest_api"... Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Loading plugin "websocket"... Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Starting Socket.io Server version 2.3.0 Jan 18 03:17:24 volumio-bedroom volumio[15283]: info: Loading plugin "Systeminfo"... Jan 18 03:17:24 volumio-bedroom volumio[15283]: Forking 3 albumart workers Jan 18 03:17:24 volumio-bedroom sudo[15339]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: Loading i18n strings for locale en Jan 18 03:17:25 volumio-bedroom volumio[15283]: Updating browse sources language Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::initPlayerControls Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: Express server listening on port 3000 Jan 18 03:17:25 volumio-bedroom volumio[15283]: [Metrics] WebUI: 8s 909.56ms Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreStateMachine::resetVolumioState Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreStateMachine::getcurrentVolume Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreStateMachine::pushState Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CorePlayQueue::getTrack 0 Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioPushState Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: Volumio Network Manager: Network status updated: 2 Jan 18 03:17:25 volumio-bedroom volumio[15283]: info: Reloading queue from file Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreStateMachine::setRepeat null single undefined Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreStateMachine::pushState Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CorePlayQueue::getTrack 0 Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioPushState Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreStateMachine::setRandom null Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreStateMachine::pushState Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CorePlayQueue::getTrack 0 Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioPushState Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: Setting Device type: Raspberry PI Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: Completed loading Core Plugins Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: Preparing to generate the ALSA configuration file Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: Asound.conf file unchanged, so no further update is needed Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: Output device has changed, restarting MPD Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: ___________ START PLUGINS ___________ Jan 18 03:17:26 volumio-bedroom sudo[15421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:17:26 volumio-bedroom sudo[15421]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: ControllerMpd::onStart: Initializing MPD Jan 18 03:17:26 volumio-bedroom sudo[15421]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: Creating MPD Configuration file Jan 18 03:17:26 volumio-bedroom sudo[15426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:17:26 volumio-bedroom sudo[15426]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:26 volumio-bedroom systemd[1]: Stopping Music Player Daemon... Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: [1737188246438] CoreMusicLibrary::Adding element Media Servers Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:17:26 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:17:26 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:17:26 volumio-bedroom sudo[15439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 18 03:17:26 volumio-bedroom sudo[15439]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:26 volumio-bedroom sudo[15437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 18 03:17:26 volumio-bedroom sudo[15437]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:26 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:17:26 volumio-bedroom sudo[15437]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: [1737188246554] CoreMusicLibrary::Adding element Last_100 Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: [1737188246565] CoreMusicLibrary::Adding element Webradio Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 18 03:17:26 volumio-bedroom systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 18 03:17:26 volumio-bedroom systemd[1]: mpd.service: Succeeded. Jan 18 03:17:26 volumio-bedroom systemd[1]: Stopped Music Player Daemon. Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: Initializing BBC Radios Jan 18 03:17:26 volumio-bedroom systemd[1]: Starting Music Player Daemon... Jan 18 03:17:26 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:17:26] [connect] Successful connection Jan 18 03:17:26 volumio-bedroom volumio[15283]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Starting proxy server... Jan 18 03:17:26 volumio-bedroom volumio[15283]: info: Volumio Calling Home Jan 18 03:17:26 volumio-bedroom volumio[15283]: Starting albumart workers Jan 18 03:17:26 volumio-bedroom sudo[15444]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 18 03:17:26 volumio-bedroom sudo[15444]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:26 volumio-bedroom sudo[15444]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:26 volumio-bedroom volumio[15283]: Starting albumart workers Jan 18 03:17:27 volumio-bedroom volumio[15283]: Starting albumart workers Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Proxy server started on port 46133 Jan 18 03:17:27 volumio-bedroom ntpd[679]: Soliciting pool server 198.23.249.167 Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioRetrievevolume Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: CoreStateMachine::pushState Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: CorePlayQueue::getTrack 0 Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioPushState Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Server discovery started Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Player finder started Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing aplay -D hw:1 --nonblock -f MPEG /dev/zero 2>&1 || true Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: MPD Permissions set Jan 18 03:17:27 volumio-bedroom volumio[15283]: info: MPD Permissions set Jan 18 03:17:27 volumio-bedroom volumio-remote-updater[521]: [2025-01-18 03:17:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737188246 101 Jan 18 03:17:28 volumio-bedroom volumio[15283]: 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: 1 Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Card 1 supports the following ALSA formats: ["U8","S16_LE"] Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"lms-bedroom","dsdFormat":null,"card":"1","mixerType":"None","mixer":null} Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 18 03:17:28 volumio-bedroom volumio[15283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom sudo[15472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jan 18 03:17:28 volumio-bedroom sudo[15472]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom sudo[15472]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Jan 18 03:17:28 volumio-bedroom sudo[15500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Jan 18 03:17:28 volumio-bedroom sudo[15500]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:28 volumio-bedroom sudo[15500]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:28 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Jan 18 03:17:29 volumio-bedroom sudo[15504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Jan 18 03:17:29 volumio-bedroom sudo[15504]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:29 volumio-bedroom sudo[15504]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:29 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Jan 18 03:17:29 volumio-bedroom sudo[15507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jan 18 03:17:29 volumio-bedroom sudo[15507]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:29 volumio-bedroom sudo[15507]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:29 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jan 18 03:17:29 volumio-bedroom sudo[15510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jan 18 03:17:29 volumio-bedroom sudo[15510]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:29 volumio-bedroom sudo[15510]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:29 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Jan 18 03:17:29 volumio-bedroom sudo[15513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Jan 18 03:17:29 volumio-bedroom sudo[15513]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:29 volumio-bedroom systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Jan 18 03:17:29 volumio-bedroom systemd[1]: squeezelite.service: Succeeded. Jan 18 03:17:29 volumio-bedroom systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Jan 18 03:17:29 volumio-bedroom sudo[15513]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:29 volumio-bedroom wpa_supplicant[781]: RRM: Ignoring radio measurement request: Not RRM network Jan 18 03:17:30 volumio-bedroom mpd[15458]: Jan 18 03:17 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 18 03:17:30 volumio-bedroom systemd[1]: Started Music Player Daemon. Jan 18 03:17:30 volumio-bedroom sudo[15439]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:30 volumio-bedroom sudo[15426]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:30 volumio-bedroom volumio[15283]: error: MPD error: The expression evaluated to a falsy value: Jan 18 03:17:30 volumio-bedroom volumio[15283]: assert.ok(self.idling) Jan 18 03:17:30 volumio-bedroom volumio[15283]: error: The expression evaluated to a falsy value: Jan 18 03:17:30 volumio-bedroom volumio[15283]: assert.ok(self.idling) Jan 18 03:17:30 volumio-bedroom volumio[15283]: error: updateQueue error: null Jan 18 03:17:30 volumio-bedroom volumio[15283]: info: MPD running with PID15458 Jan 18 03:17:30 volumio-bedroom volumio[15283]: ,establishing connection Jan 18 03:17:30 volumio-bedroom volumio[15283]: error: updateQueue error: null Jan 18 03:17:30 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jan 18 03:17:30 volumio-bedroom sudo[15520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jan 18 03:17:30 volumio-bedroom sudo[15520]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:30 volumio-bedroom sudo[15520]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:30 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing rm /tmp/squeezelite.log Jan 18 03:17:30 volumio-bedroom sudo[15540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /tmp/squeezelite.log Jan 18 03:17:30 volumio-bedroom sudo[15540]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:30 volumio-bedroom sudo[15540]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:30 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Jan 18 03:17:30 volumio-bedroom sudo[15544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Jan 18 03:17:30 volumio-bedroom sudo[15544]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:30 volumio-bedroom sudo[15547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 18 03:17:30 volumio-bedroom sudo[15547]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:30 volumio-bedroom sudo[15550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 18 03:17:30 volumio-bedroom systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jan 18 03:17:30 volumio-bedroom sudo[15550]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:30 volumio-bedroom sudo[15547]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:30 volumio-bedroom sudo[15550]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:30 volumio-bedroom sudo[15556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 18 03:17:30 volumio-bedroom sudo[15556]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:30 volumio-bedroom systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jan 18 03:17:30 volumio-bedroom sudo[15544]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:31 volumio-bedroom sudo[15556]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:31 volumio-bedroom volumio[15283]: info: Upmpdcli Daemon Started Jan 18 03:17:31 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jan 18 03:17:31 volumio-bedroom sudo[15562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jan 18 03:17:31 volumio-bedroom sudo[15562]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:31 volumio-bedroom sudo[15562]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:32 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jan 18 03:17:32 volumio-bedroom sudo[15565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jan 18 03:17:32 volumio-bedroom sudo[15565]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:32 volumio-bedroom sudo[15565]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:32 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jan 18 03:17:32 volumio-bedroom sudo[15568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jan 18 03:17:32 volumio-bedroom sudo[15568]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:32 volumio-bedroom sudo[15568]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:33 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jan 18 03:17:33 volumio-bedroom sudo[15571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jan 18 03:17:33 volumio-bedroom sudo[15571]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:33 volumio-bedroom sudo[15571]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:33 volumio-bedroom volumio[15283]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jan 18 03:17:33 volumio-bedroom sudo[15574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jan 18 03:17:33 volumio-bedroom sudo[15574]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:33 volumio-bedroom sudo[15574]: pam_unix(sudo:session): session closed for user root Jan 18 03:17:33 volumio-bedroom volumio[15283]: info: Completed starting Core Plugins Jan 18 03:17:33 volumio-bedroom volumio[15283]: info: ------------------------------------------- Jan 18 03:17:33 volumio-bedroom volumio[15283]: info: ----- MyVolumio plugins startup ---- Jan 18 03:17:33 volumio-bedroom volumio[15283]: info: ------------------------------------------- Jan 18 03:17:33 volumio-bedroom volumio[15283]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 18 03:17:35 volumio-bedroom volumio[15283]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 18 03:17:35 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-DISCONNECTED bssid=3a:de:4b:76:33:a4 reason=8 Jan 18 03:17:35 volumio-bedroom dhcpcd[795]: wlan0: carrier lost Jan 18 03:17:35 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Jan 18 03:17:35 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=US Jan 18 03:17:35 volumio-bedroom avahi-daemon[536]: Withdrawing address record for 169.254.250.27 on wlan0. Jan 18 03:17:35 volumio-bedroom avahi-daemon[536]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.250.27. Jan 18 03:17:35 volumio-bedroom avahi-daemon[536]: Interface wlan0.IPv4 no longer relevant for mDNS. Jan 18 03:17:35 volumio-bedroom dhcpcd[795]: wlan0: deleting route to 169.254.0.0/16 Jan 18 03:17:35 volumio-bedroom dhcpcd[795]: wlan0: deleting default route Jan 18 03:17:35 volumio-bedroom volumio[15283]: info: Discovery: A device disappeared from network Jan 18 03:17:35 volumio-bedroom volumio[15283]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Jan 18 03:17:37 volumio-bedroom ntpd[679]: Deleting interface #4 wlan0, 169.254.250.27#123, interface stats: received=0, sent=7, dropped=0, active_time=16 secs Jan 18 03:17:37 volumio-bedroom ntpd[679]: 66.228.59.187 local addr 169.254.250.27 -> Jan 18 03:17:37 volumio-bedroom ntpd[679]: 216.31.16.12 local addr 169.254.250.27 -> Jan 18 03:17:37 volumio-bedroom ntpd[679]: 23.168.136.132 local addr 169.254.250.27 -> Jan 18 03:17:37 volumio-bedroom ntpd[679]: 216.229.4.69 local addr 169.254.250.27 -> Jan 18 03:17:37 volumio-bedroom ntpd[679]: 74.6.168.73 local addr 169.254.250.27 -> Jan 18 03:17:37 volumio-bedroom ntpd[679]: 5.78.62.36 local addr 169.254.250.27 -> Jan 18 03:17:37 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:17:37 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:17:37 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:17:37 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumioGetState Jan 18 03:17:37 volumio-bedroom volumio[15283]: info: CorePlayQueue::getTrack 0 Jan 18 03:17:37 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:17:39 volumio-bedroom kernel: hwmon hwmon1: Voltage normalised Jan 18 03:17:40 volumio-bedroom wpa_supplicant[781]: wlan0: Trying to associate with SSID 'Home' Jan 18 03:17:40 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Jan 18 03:17:40 volumio-bedroom volumio[15283]: info: Volumio Network Manager: Network status updated: 0 Jan 18 03:17:41 volumio-bedroom volumio[15283]: info: Discovery: Browse raised the following error Error: getaddrinfo -3008 Jan 18 03:17:42 volumio-bedroom kernel: hwmon hwmon1: Undervoltage detected! Jan 18 03:17:42 volumio-bedroom ntpd[679]: Soliciting pool server 2a01:4ff:1f0:c33f::1 Jan 18 03:17:44 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd022 fail, reason -52 Jan 18 03:17:44 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd026 fail, reason -52 Jan 18 03:17:44 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02a fail, reason -52 Jan 18 03:17:44 volumio-bedroom kernel: brcmfmac: brcmf_set_channel: set chanspec 0xd02e fail, reason -52 Jan 18 03:17:47 volumio-bedroom volumio[15283]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.785&uuid=54bb584b75331ed3ef62525024f0f527" http://updates.volumio.org/downloader-v1/track-device Jan 18 03:17:47 volumio-bedroom volumio[15283]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 18 03:17:47 volumio-bedroom volumio[15283]: Dload Upload Total Spent Left Speed Jan 18 03:17:47 volumio-bedroom volumio[15283]: [922B blob data] Jan 18 03:17:47 volumio-bedroom volumio[15283]: retrying in 5 seconds, trial 0 Jan 18 03:17:47 volumio-bedroom volumio[15283]: info: Volumio Calling Home Jan 18 03:17:47 volumio-bedroom wpa_supplicant[781]: wlan0: Trying to associate with SSID 'Home' Jan 18 03:17:47 volumio-bedroom wpa_supplicant[781]: wlan0: Associated with 36:de:4b:76:33:8b Jan 18 03:17:47 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-CONNECTED - Connection to 36:de:4b:76:33:8b completed [id=0 id_str=] Jan 18 03:17:47 volumio-bedroom dhcpcd[795]: wlan0: carrier acquired Jan 18 03:17:47 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 18 03:17:47 volumio-bedroom wpa_supplicant[781]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jan 18 03:17:47 volumio-bedroom dhcpcd[795]: wlan0: IAID eb:35:96:7a Jan 18 03:17:47 volumio-bedroom dhcpcd[795]: wlan0: soliciting an IPv6 router Jan 18 03:17:47 volumio-bedroom wpa_supplicant[781]: RRM: Ignoring radio measurement request: Not RRM network Jan 18 03:17:48 volumio-bedroom dhcpcd[795]: wlan0: soliciting a DHCP lease Jan 18 03:17:51 volumio-bedroom dhcpcd[795]: wlan0: offered 192.168.3.67 from 192.168.0.1 Jan 18 03:17:51 volumio-bedroom dhcpcd[795]: wlan0: probing address 192.168.3.67/22 Jan 18 03:17:53 volumio-bedroom wpa_supplicant[781]: RRM: Ignoring radio measurement request: Not RRM network Jan 18 03:17:53 volumio-bedroom volumio[15283]: error: MyVolumio Plugin failed to start in a timely fashion Jan 18 03:17:53 volumio-bedroom volumio[15283]: [Metrics] CommandRouter: 36s 690.83ms Jan 18 03:17:53 volumio-bedroom volumio[15283]: info: CoreCommandRouter::volumiosetStartupVolume Jan 18 03:17:53 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 18 03:17:53 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:53 volumio-bedroom volumio[15283]: info: CoreCommandRouter::Close All Modals sent Jan 18 03:17:53 volumio-bedroom volumio[15283]: info: CoreCommandRouter::Close All Modals sent Jan 18 03:17:54 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 18 03:17:54 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 18 03:17:54 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 18 03:17:56 volumio-bedroom kernel: hwmon hwmon1: Voltage normalised Jan 18 03:17:56 volumio-bedroom volumio[15283]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jan 18 03:17:56 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:56 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 18 03:17:56 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 18 03:17:56 volumio-bedroom volumio[15283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 18 03:17:57 volumio-bedroom volumio[15283]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.785&uuid=54bb584b75331ed3ef62525024f0f527" http://updates.volumio.org/downloader-v1/track-device Jan 18 03:17:57 volumio-bedroom volumio[15283]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 18 03:17:57 volumio-bedroom volumio[15283]: Dload Upload Total Spent Left Speed Jan 18 03:17:57 volumio-bedroom volumio[15283]: [132B blob data] Jan 18 03:17:57 volumio-bedroom volumio[15283]: retrying in 5 seconds, trial 1 Jan 18 03:17:57 volumio-bedroom volumio[15283]: info: Volumio Calling Home Jan 18 03:17:57 volumio-bedroom volumio[15283]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:17:57 volumio-bedroom volumio[15283]: Error: send ENETUNREACH 255.255.255.255:3483 Jan 18 03:17:57 volumio-bedroom volumio[15283]: at doSend (dgram.js:692:16) Jan 18 03:17:57 volumio-bedroom volumio[15283]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Jan 18 03:17:57 volumio-bedroom volumio[15283]: at afterDns (dgram.js:638:5) Jan 18 03:17:57 volumio-bedroom volumio[15283]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Jan 18 03:17:57 volumio-bedroom volumio[15283]: errno: -101, Jan 18 03:17:57 volumio-bedroom volumio[15283]: code: 'ENETUNREACH', Jan 18 03:17:57 volumio-bedroom volumio[15283]: syscall: 'send', Jan 18 03:17:57 volumio-bedroom volumio[15283]: address: '255.255.255.255', Jan 18 03:17:57 volumio-bedroom volumio[15283]: port: 3483 Jan 18 03:17:57 volumio-bedroom volumio[15283]: } Jan 18 03:17:57 volumio-bedroom volumio[15283]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 18 03:17:57 volumio-bedroom dhcpcd[795]: wlan0: leased 192.168.3.67 for 7200 seconds Jan 18 03:17:57 volumio-bedroom avahi-daemon[536]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.3.67. Jan 18 03:17:57 volumio-bedroom avahi-daemon[536]: New relevant interface wlan0.IPv4 for mDNS. Jan 18 03:17:57 volumio-bedroom dhcpcd[795]: wlan0: adding route to 192.168.0.0/22 Jan 18 03:17:57 volumio-bedroom avahi-daemon[536]: Registering new address record for 192.168.3.67 on wlan0.IPv4. Jan 18 03:17:57 volumio-bedroom dhcpcd[795]: wlan0: adding default route via 192.168.0.1 Jan 18 03:17:58 volumio-bedroom sudo[15686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-18 03:16 Jan 18 03:17:58 volumio-bedroom sudo[15686]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 18 03:17:58 volumio-bedroom kernel: hwmon hwmon1: Undervoltage detected! 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"