-- Logs begin at Sun 2023-11-19 13:04:04 GMT, end at Sun 2023-11-19 13:41:38 GMT. -- Nov 19 13:40:01 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:40:01 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:40:01 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:01 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:01 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:40:01 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72976. Nov 19 13:40:01 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:40:01 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:40:01 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:01 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:02 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:02] [connect] Successful connection Nov 19 13:40:02 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:02] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:40:02 chris-volumio volumio[27439]: info: ------------------------------------------- Nov 19 13:40:02 chris-volumio volumio[27439]: info: ----- Volumio3 ---- Nov 19 13:40:02 chris-volumio volumio[27439]: info: ------------------------------------------- Nov 19 13:40:02 chris-volumio volumio[27439]: info: ----- System startup ---- Nov 19 13:40:02 chris-volumio volumio[27439]: info: ------------------------------------------- Nov 19 13:40:03 chris-volumio volumio[27439]: info: MYVOLUMIO Environment detected Nov 19 13:40:03 chris-volumio volumio[27439]: info: Plugin folders cleanup Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning category audio_interface Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning category miscellanea Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning category music_service Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning category plugins.json Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning category system_controller Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning category user_interface Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning into folder /data/plugins/ Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning category audio_interface Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning category music_service Nov 19 13:40:03 chris-volumio volumio[27439]: info: Scanning category user_interface Nov 19 13:40:03 chris-volumio volumio[27439]: info: Plugin folders cleanup completed Nov 19 13:40:03 chris-volumio volumio[27439]: info: ------------------------------------------- Nov 19 13:40:03 chris-volumio volumio[27439]: info: ----- Core plugins startup ---- Nov 19 13:40:03 chris-volumio volumio[27439]: info: ------------------------------------------- Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:40:03 chris-volumio volumio[27439]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:40:03 chris-volumio volumio[27439]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:40:03 chris-volumio volumio[27439]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugins from folder /data/plugins/ Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "system"... Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "appearance"... Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "network"... Nov 19 13:40:03 chris-volumio volumio[27439]: info: Refreshing Cached IP Addresses Nov 19 13:40:03 chris-volumio sudo[27463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:40:03 chris-volumio sudo[27463]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:03 chris-volumio sudo[27463]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "services"... Nov 19 13:40:03 chris-volumio sudo[27466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:40:03 chris-volumio sudo[27466]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "alsa_controller"... Nov 19 13:40:03 chris-volumio sudo[27466]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:03 chris-volumio sudo[27468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:40:03 chris-volumio sudo[27468]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:03 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "wizard"... Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "upnp"... Nov 19 13:40:03 chris-volumio volumio[27439]: info: [1700401203924] Starting Upmpd Daemon Nov 19 13:40:03 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "my_music"... Nov 19 13:40:03 chris-volumio volumio[27439]: info: Loading plugin "mpd"... Nov 19 13:40:04 chris-volumio volumio[27439]: info: Creating MPD Configuration file Nov 19 13:40:04 chris-volumio sudo[27474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:40:04 chris-volumio sudo[27474]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:04 chris-volumio volumio[27439]: info: Loading plugin "upnp_browser"... Nov 19 13:40:04 chris-volumio sudo[27474]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:04 chris-volumio sudo[27476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:40:04 chris-volumio sudo[27476]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:04 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:40:04 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:40:04 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:40:04 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:40:04 chris-volumio volumio[27439]: info: Loading plugin "networkfs"... Nov 19 13:40:04 chris-volumio volumio[27439]: info: Starting Udev Watcher for removable devices Nov 19 13:40:04 chris-volumio sudo[27484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:40:04 chris-volumio sudo[27484]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:04 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:40:04 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:40:04 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 19 13:40:04 chris-volumio sudo[27484]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:04 chris-volumio volumio[27439]: info: Ignoring mount for partition: boot Nov 19 13:40:04 chris-volumio volumio[27439]: info: Ignoring mount for partition: volumio Nov 19 13:40:04 chris-volumio volumio[27439]: info: Ignoring mount for partition: volumio_data Nov 19 13:40:04 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:04 chris-volumio volumio[27439]: info: Loading plugin "alarm-clock"... Nov 19 13:40:04 chris-volumio volumio[27439]: info: Loading plugin "airplay_emulation"... Nov 19 13:40:04 chris-volumio volumio[27439]: info: Starting Shairport Sync Nov 19 13:40:04 chris-volumio volumio[27439]: info: Loading plugin "last_100"... Nov 19 13:40:04 chris-volumio volumio[27439]: info: Loading plugin "webradio"... Nov 19 13:40:04 chris-volumio volumio[27439]: info: Loading plugin "i2s_dacs"... Nov 19 13:40:04 chris-volumio volumio[27439]: info: Loading plugin "volumiodiscovery"... Nov 19 13:40:04 chris-volumio volumio[27439]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:04 chris-volumio node[27439]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:04 chris-volumio node[27439]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:04 chris-volumio volumio[27439]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:04 chris-volumio volumio[27439]: *** WARNING *** For more information see Nov 19 13:40:04 chris-volumio volumio[27439]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:04 chris-volumio volumio[27439]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:04 chris-volumio volumio[27439]: *** WARNING *** For more information see Nov 19 13:40:04 chris-volumio node[27439]: *** WARNING *** For more information see Nov 19 13:40:04 chris-volumio node[27439]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:04 chris-volumio node[27439]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:04 chris-volumio node[27439]: *** WARNING *** For more information see Nov 19 13:40:04 chris-volumio volumio[27439]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:40:04 chris-volumio volumio[27439]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:40:04 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:04 chris-volumio volumio[27439]: info: Loading plugin "ytcr"... Nov 19 13:40:04 chris-volumio mpd[27481]: Nov 19 13:40 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:40:05 chris-volumio mpd[27481]: Nov 19 13:40 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:40:05 chris-volumio mpd[27481]: Nov 19 13:40 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:40:05 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:40:05 chris-volumio sudo[27476]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:05 chris-volumio volumio[27439]: info: Loading plugin "now_playing"... Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "outputs"... Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "albumart"... Nov 19 13:40:06 chris-volumio volumio[27439]: info: Plugin example_plugin is not enabled Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "inputs"... Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "updater_comm"... Nov 19 13:40:06 chris-volumio volumio[27439]: info: Plugin mpdemulation is not enabled Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "rest_api"... Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "websocket"... Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "fusiondsp"... Nov 19 13:40:06 chris-volumio volumio[27439]: Forking 3 albumart workers Nov 19 13:40:06 chris-volumio sudo[27468]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:06 chris-volumio volumio[27439]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "RoonBridge"... Nov 19 13:40:06 chris-volumio volumio[27439]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "radio_paradise"... Nov 19 13:40:06 chris-volumio volumio[27439]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:40:06 chris-volumio volumio[27439]: info: [1700401206890] [RadioParadise] API delay: 5 Nov 19 13:40:06 chris-volumio volumio[27439]: info: Loading plugin "lastfm"... Nov 19 13:40:06 chris-volumio volumio[27439]: Starting albumart workers Nov 19 13:40:06 chris-volumio volumio[27439]: Starting albumart workers Nov 19 13:40:07 chris-volumio volumio[27439]: Starting albumart workers Nov 19 13:40:07 chris-volumio volumio[27439]: info: Loading i18n strings for locale en Nov 19 13:40:07 chris-volumio volumio[27439]: Updating browse sources language Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::initPlayerControls Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:07 chris-volumio volumio[27439]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:07 chris-volumio volumio[27439]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:40:07 chris-volumio volumio[27439]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:40:07 chris-volumio volumio[27439]: at listenInCluster (net.js:1366:12) Nov 19 13:40:07 chris-volumio volumio[27439]: at Server.listen (net.js:1452:7) Nov 19 13:40:07 chris-volumio volumio[27439]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:40:07 chris-volumio volumio[27439]: at Object. (/volumio/index.js:26:29) Nov 19 13:40:07 chris-volumio volumio[27439]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:40:07 chris-volumio volumio[27439]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:40:07 chris-volumio volumio[27439]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:40:07 chris-volumio volumio[27439]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:40:07 chris-volumio volumio[27439]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:40:07 chris-volumio volumio[27439]: code: 'EADDRINUSE', Nov 19 13:40:07 chris-volumio volumio[27439]: errno: -98, Nov 19 13:40:07 chris-volumio volumio[27439]: syscall: 'listen', Nov 19 13:40:07 chris-volumio volumio[27439]: address: '::', Nov 19 13:40:07 chris-volumio volumio[27439]: port: 3000 Nov 19 13:40:07 chris-volumio volumio[27439]: } Nov 19 13:40:07 chris-volumio volumio[27439]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:07 chris-volumio sudo[27554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:39 Nov 19 13:40:07 chris-volumio sudo[27554]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:07 chris-volumio sudo[27554]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:07 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:40:07 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:40:07 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:08 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:08 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:40:08 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72977. Nov 19 13:40:08 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:40:08 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:40:08 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:08 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:09 chris-volumio volumio[27567]: info: ------------------------------------------- Nov 19 13:40:09 chris-volumio volumio[27567]: info: ----- Volumio3 ---- Nov 19 13:40:09 chris-volumio volumio[27567]: info: ------------------------------------------- Nov 19 13:40:09 chris-volumio volumio[27567]: info: ----- System startup ---- Nov 19 13:40:09 chris-volumio volumio[27567]: info: ------------------------------------------- Nov 19 13:40:09 chris-volumio volumio[27567]: info: MYVOLUMIO Environment detected Nov 19 13:40:09 chris-volumio volumio[27567]: info: Plugin folders cleanup Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning category audio_interface Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning category miscellanea Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning category music_service Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning category plugins.json Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning category system_controller Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning category user_interface Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning into folder /data/plugins/ Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning category audio_interface Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning category music_service Nov 19 13:40:09 chris-volumio volumio[27567]: info: Scanning category user_interface Nov 19 13:40:09 chris-volumio volumio[27567]: info: Plugin folders cleanup completed Nov 19 13:40:09 chris-volumio volumio[27567]: info: ------------------------------------------- Nov 19 13:40:09 chris-volumio volumio[27567]: info: ----- Core plugins startup ---- Nov 19 13:40:09 chris-volumio volumio[27567]: info: ------------------------------------------- Nov 19 13:40:09 chris-volumio volumio[27567]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:40:09 chris-volumio volumio[27567]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:40:09 chris-volumio volumio[27567]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:40:09 chris-volumio volumio[27567]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:40:09 chris-volumio volumio[27567]: info: Loading plugins from folder /data/plugins/ Nov 19 13:40:09 chris-volumio volumio[27567]: info: Loading plugin "system"... Nov 19 13:40:09 chris-volumio volumio[27567]: info: Loading plugin "appearance"... Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "network"... Nov 19 13:40:10 chris-volumio volumio[27567]: info: Refreshing Cached IP Addresses Nov 19 13:40:10 chris-volumio sudo[27591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:40:10 chris-volumio sudo[27591]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:10 chris-volumio sudo[27591]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:10 chris-volumio sudo[27593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:40:10 chris-volumio sudo[27593]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "services"... Nov 19 13:40:10 chris-volumio sudo[27593]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "alsa_controller"... Nov 19 13:40:10 chris-volumio sudo[27596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:40:10 chris-volumio sudo[27596]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:10 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "wizard"... Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "upnp"... Nov 19 13:40:10 chris-volumio volumio[27567]: info: [1700401210437] Starting Upmpd Daemon Nov 19 13:40:10 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "my_music"... Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "mpd"... Nov 19 13:40:10 chris-volumio volumio[27567]: info: Creating MPD Configuration file Nov 19 13:40:10 chris-volumio sudo[27602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:40:10 chris-volumio sudo[27602]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "upnp_browser"... Nov 19 13:40:10 chris-volumio sudo[27602]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:10 chris-volumio sudo[27604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:40:10 chris-volumio sudo[27604]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:10 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:40:10 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:40:10 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:40:10 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:40:10 chris-volumio volumio[27567]: info: Loading plugin "networkfs"... Nov 19 13:40:10 chris-volumio volumio[27567]: info: Starting Udev Watcher for removable devices Nov 19 13:40:11 chris-volumio sudo[27612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:40:11 chris-volumio sudo[27612]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:11 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:40:11 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:40:11 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 19 13:40:11 chris-volumio sudo[27612]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:11 chris-volumio volumio[27567]: info: Ignoring mount for partition: boot Nov 19 13:40:11 chris-volumio volumio[27567]: info: Ignoring mount for partition: volumio Nov 19 13:40:11 chris-volumio volumio[27567]: info: Ignoring mount for partition: volumio_data Nov 19 13:40:11 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:11 chris-volumio volumio[27567]: info: Loading plugin "alarm-clock"... Nov 19 13:40:11 chris-volumio volumio[27567]: info: Loading plugin "airplay_emulation"... Nov 19 13:40:11 chris-volumio volumio[27567]: info: Starting Shairport Sync Nov 19 13:40:11 chris-volumio volumio[27567]: info: Loading plugin "last_100"... Nov 19 13:40:11 chris-volumio volumio[27567]: info: Loading plugin "webradio"... Nov 19 13:40:11 chris-volumio volumio[27567]: info: Loading plugin "i2s_dacs"... Nov 19 13:40:11 chris-volumio volumio[27567]: info: Loading plugin "volumiodiscovery"... Nov 19 13:40:11 chris-volumio volumio[27567]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:11 chris-volumio node[27567]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:11 chris-volumio node[27567]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:11 chris-volumio volumio[27567]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:11 chris-volumio volumio[27567]: *** WARNING *** For more information see Nov 19 13:40:11 chris-volumio volumio[27567]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:11 chris-volumio volumio[27567]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:11 chris-volumio volumio[27567]: *** WARNING *** For more information see Nov 19 13:40:11 chris-volumio node[27567]: *** WARNING *** For more information see Nov 19 13:40:11 chris-volumio node[27567]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:11 chris-volumio node[27567]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:11 chris-volumio node[27567]: *** WARNING *** For more information see Nov 19 13:40:11 chris-volumio volumio[27567]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:40:11 chris-volumio volumio[27567]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:40:11 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:11 chris-volumio volumio[27567]: info: Loading plugin "ytcr"... Nov 19 13:40:11 chris-volumio mpd[27609]: Nov 19 13:40 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:40:11 chris-volumio mpd[27609]: Nov 19 13:40 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:40:11 chris-volumio mpd[27609]: Nov 19 13:40 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:40:11 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:40:11 chris-volumio sudo[27604]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:12 chris-volumio volumio[27567]: info: Loading plugin "now_playing"... Nov 19 13:40:12 chris-volumio volumio[27567]: info: Loading plugin "outputs"... Nov 19 13:40:12 chris-volumio volumio[27567]: info: Loading plugin "albumart"... Nov 19 13:40:12 chris-volumio volumio[27567]: info: Plugin example_plugin is not enabled Nov 19 13:40:12 chris-volumio volumio[27567]: info: Loading plugin "inputs"... Nov 19 13:40:12 chris-volumio volumio[27567]: info: Loading plugin "updater_comm"... Nov 19 13:40:12 chris-volumio volumio[27567]: info: Plugin mpdemulation is not enabled Nov 19 13:40:12 chris-volumio volumio[27567]: info: Loading plugin "rest_api"... Nov 19 13:40:12 chris-volumio volumio[27567]: info: Loading plugin "websocket"... Nov 19 13:40:12 chris-volumio volumio[27567]: info: Loading plugin "fusiondsp"... Nov 19 13:40:12 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:12] [connect] Successful connection Nov 19 13:40:12 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:12] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:40:12 chris-volumio volumio[27567]: Forking 3 albumart workers Nov 19 13:40:12 chris-volumio sudo[27596]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:12 chris-volumio volumio[27567]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:40:13 chris-volumio volumio[27567]: info: Loading plugin "RoonBridge"... Nov 19 13:40:13 chris-volumio volumio[27567]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:40:13 chris-volumio volumio[27567]: info: Loading plugin "radio_paradise"... Nov 19 13:40:13 chris-volumio volumio[27567]: Starting albumart workers Nov 19 13:40:13 chris-volumio volumio[27567]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:40:13 chris-volumio volumio[27567]: info: [1700401213462] [RadioParadise] API delay: 5 Nov 19 13:40:13 chris-volumio volumio[27567]: info: Loading plugin "lastfm"... Nov 19 13:40:13 chris-volumio volumio[27567]: Starting albumart workers Nov 19 13:40:13 chris-volumio volumio[27567]: Starting albumart workers Nov 19 13:40:13 chris-volumio volumio[27567]: info: Loading i18n strings for locale en Nov 19 13:40:13 chris-volumio volumio[27567]: Updating browse sources language Nov 19 13:40:13 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::initPlayerControls Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:14 chris-volumio volumio[27567]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:14 chris-volumio volumio[27567]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:40:14 chris-volumio volumio[27567]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:40:14 chris-volumio volumio[27567]: at listenInCluster (net.js:1366:12) Nov 19 13:40:14 chris-volumio volumio[27567]: at Server.listen (net.js:1452:7) Nov 19 13:40:14 chris-volumio volumio[27567]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:40:14 chris-volumio volumio[27567]: at Object. (/volumio/index.js:26:29) Nov 19 13:40:14 chris-volumio volumio[27567]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:40:14 chris-volumio volumio[27567]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:40:14 chris-volumio volumio[27567]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:40:14 chris-volumio volumio[27567]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:40:14 chris-volumio volumio[27567]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:40:14 chris-volumio volumio[27567]: code: 'EADDRINUSE', Nov 19 13:40:14 chris-volumio volumio[27567]: errno: -98, Nov 19 13:40:14 chris-volumio volumio[27567]: syscall: 'listen', Nov 19 13:40:14 chris-volumio volumio[27567]: address: '::', Nov 19 13:40:14 chris-volumio volumio[27567]: port: 3000 Nov 19 13:40:14 chris-volumio volumio[27567]: } Nov 19 13:40:14 chris-volumio volumio[27567]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:14 chris-volumio ntpd[672]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 19 13:40:14 chris-volumio sudo[27681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:39 Nov 19 13:40:14 chris-volumio sudo[27681]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:14 chris-volumio sudo[27681]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:20 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:40:20 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:40:20 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:20 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:20 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:40:20 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72978. Nov 19 13:40:20 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:40:20 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:40:20 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:20 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:21 chris-volumio volumio[27695]: info: ------------------------------------------- Nov 19 13:40:21 chris-volumio volumio[27695]: info: ----- Volumio3 ---- Nov 19 13:40:21 chris-volumio volumio[27695]: info: ------------------------------------------- Nov 19 13:40:21 chris-volumio volumio[27695]: info: ----- System startup ---- Nov 19 13:40:21 chris-volumio volumio[27695]: info: ------------------------------------------- Nov 19 13:40:22 chris-volumio volumio[27695]: info: MYVOLUMIO Environment detected Nov 19 13:40:22 chris-volumio volumio[27695]: info: Plugin folders cleanup Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning category audio_interface Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning category miscellanea Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning category music_service Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning category plugins.json Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning category system_controller Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning category user_interface Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning into folder /data/plugins/ Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning category audio_interface Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning category music_service Nov 19 13:40:22 chris-volumio volumio[27695]: info: Scanning category user_interface Nov 19 13:40:22 chris-volumio volumio[27695]: info: Plugin folders cleanup completed Nov 19 13:40:22 chris-volumio volumio[27695]: info: ------------------------------------------- Nov 19 13:40:22 chris-volumio volumio[27695]: info: ----- Core plugins startup ---- Nov 19 13:40:22 chris-volumio volumio[27695]: info: ------------------------------------------- Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:40:22 chris-volumio volumio[27695]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:40:22 chris-volumio volumio[27695]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:40:22 chris-volumio volumio[27695]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugins from folder /data/plugins/ Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "system"... Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "appearance"... Nov 19 13:40:22 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:22] [connect] Successful connection Nov 19 13:40:22 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:22] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "network"... Nov 19 13:40:22 chris-volumio volumio[27695]: info: Refreshing Cached IP Addresses Nov 19 13:40:22 chris-volumio sudo[27719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:40:22 chris-volumio sudo[27719]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:22 chris-volumio sudo[27719]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "services"... Nov 19 13:40:22 chris-volumio sudo[27721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:40:22 chris-volumio sudo[27721]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "alsa_controller"... Nov 19 13:40:22 chris-volumio sudo[27721]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:22 chris-volumio sudo[27724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:40:22 chris-volumio sudo[27724]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:22 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "wizard"... Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "upnp"... Nov 19 13:40:22 chris-volumio volumio[27695]: info: [1700401222887] Starting Upmpd Daemon Nov 19 13:40:22 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "my_music"... Nov 19 13:40:22 chris-volumio volumio[27695]: info: Loading plugin "mpd"... Nov 19 13:40:23 chris-volumio volumio[27695]: info: Creating MPD Configuration file Nov 19 13:40:23 chris-volumio sudo[27730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:40:23 chris-volumio sudo[27730]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:23 chris-volumio volumio[27695]: info: Loading plugin "upnp_browser"... Nov 19 13:40:23 chris-volumio sudo[27730]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:23 chris-volumio sudo[27732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:40:23 chris-volumio sudo[27732]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:23 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:40:23 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:40:23 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:40:23 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:40:23 chris-volumio volumio[27695]: info: Loading plugin "networkfs"... Nov 19 13:40:23 chris-volumio volumio[27695]: info: Starting Udev Watcher for removable devices Nov 19 13:40:23 chris-volumio sudo[27740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:40:23 chris-volumio sudo[27740]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:23 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:40:23 chris-volumio volumio[27695]: info: Ignoring mount for partition: boot Nov 19 13:40:23 chris-volumio volumio[27695]: info: Ignoring mount for partition: volumio Nov 19 13:40:23 chris-volumio volumio[27695]: info: Ignoring mount for partition: volumio_data Nov 19 13:40:23 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:23 chris-volumio volumio[27695]: info: Loading plugin "alarm-clock"... Nov 19 13:40:23 chris-volumio volumio[27695]: info: Loading plugin "airplay_emulation"... Nov 19 13:40:23 chris-volumio volumio[27695]: info: Starting Shairport Sync Nov 19 13:40:23 chris-volumio volumio[27695]: info: Loading plugin "last_100"... Nov 19 13:40:23 chris-volumio volumio[27695]: info: Loading plugin "webradio"... Nov 19 13:40:23 chris-volumio volumio[27695]: info: Loading plugin "i2s_dacs"... Nov 19 13:40:23 chris-volumio volumio[27695]: info: Loading plugin "volumiodiscovery"... Nov 19 13:40:23 chris-volumio volumio[27695]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:23 chris-volumio volumio[27695]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:23 chris-volumio node[27695]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:23 chris-volumio volumio[27695]: *** WARNING *** For more information see Nov 19 13:40:23 chris-volumio volumio[27695]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:23 chris-volumio volumio[27695]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:23 chris-volumio volumio[27695]: *** WARNING *** For more information see Nov 19 13:40:23 chris-volumio node[27695]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:23 chris-volumio node[27695]: *** WARNING *** For more information see Nov 19 13:40:23 chris-volumio node[27695]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:23 chris-volumio node[27695]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:23 chris-volumio node[27695]: *** WARNING *** For more information see Nov 19 13:40:23 chris-volumio volumio[27695]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:40:23 chris-volumio volumio[27695]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:40:23 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:23 chris-volumio volumio[27695]: info: Loading plugin "ytcr"... Nov 19 13:40:23 chris-volumio mpd[27737]: Nov 19 13:40 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:40:24 chris-volumio mpd[27737]: Nov 19 13:40 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:40:24 chris-volumio mpd[27737]: Nov 19 13:40 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:40:24 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:40:24 chris-volumio sudo[27732]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:24 chris-volumio volumio[27695]: info: Loading plugin "now_playing"... Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "outputs"... Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "albumart"... Nov 19 13:40:25 chris-volumio volumio[27695]: info: Plugin example_plugin is not enabled Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "inputs"... Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "updater_comm"... Nov 19 13:40:25 chris-volumio volumio[27695]: info: Plugin mpdemulation is not enabled Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "rest_api"... Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "websocket"... Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "fusiondsp"... Nov 19 13:40:25 chris-volumio volumio[27695]: Forking 3 albumart workers Nov 19 13:40:25 chris-volumio volumio[27695]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:40:25 chris-volumio sudo[27724]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "RoonBridge"... Nov 19 13:40:25 chris-volumio volumio[27695]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "radio_paradise"... Nov 19 13:40:25 chris-volumio volumio[27695]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:40:25 chris-volumio volumio[27695]: info: [1700401225834] [RadioParadise] API delay: 5 Nov 19 13:40:25 chris-volumio volumio[27695]: info: Loading plugin "lastfm"... Nov 19 13:40:25 chris-volumio volumio[27695]: Starting albumart workers Nov 19 13:40:25 chris-volumio volumio[27695]: Starting albumart workers Nov 19 13:40:25 chris-volumio volumio[27695]: Starting albumart workers Nov 19 13:40:26 chris-volumio volumio[27695]: info: Loading i18n strings for locale en Nov 19 13:40:26 chris-volumio volumio[27695]: Updating browse sources language Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::initPlayerControls Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:26 chris-volumio volumio[27695]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:26 chris-volumio volumio[27695]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:40:26 chris-volumio volumio[27695]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:40:26 chris-volumio volumio[27695]: at listenInCluster (net.js:1366:12) Nov 19 13:40:26 chris-volumio volumio[27695]: at Server.listen (net.js:1452:7) Nov 19 13:40:26 chris-volumio volumio[27695]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:40:26 chris-volumio volumio[27695]: at Object. (/volumio/index.js:26:29) Nov 19 13:40:26 chris-volumio volumio[27695]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:40:26 chris-volumio volumio[27695]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:40:26 chris-volumio volumio[27695]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:40:26 chris-volumio volumio[27695]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:40:26 chris-volumio volumio[27695]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:40:26 chris-volumio volumio[27695]: code: 'EADDRINUSE', Nov 19 13:40:26 chris-volumio volumio[27695]: errno: -98, Nov 19 13:40:26 chris-volumio volumio[27695]: syscall: 'listen', Nov 19 13:40:26 chris-volumio volumio[27695]: address: '::', Nov 19 13:40:26 chris-volumio volumio[27695]: port: 3000 Nov 19 13:40:26 chris-volumio volumio[27695]: } Nov 19 13:40:26 chris-volumio volumio[27695]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:26 chris-volumio sudo[27809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:39 Nov 19 13:40:26 chris-volumio sudo[27809]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:26 chris-volumio sudo[27809]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:26 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:40:26 chris-volumio sudo[27740]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:26 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:40:26 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -4 Nov 19 13:40:26 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:40:26 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:27 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:27 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:40:27 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72979. Nov 19 13:40:27 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:27 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:40:27 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:40:27 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:28 chris-volumio volumio[27823]: info: ------------------------------------------- Nov 19 13:40:28 chris-volumio volumio[27823]: info: ----- Volumio3 ---- Nov 19 13:40:28 chris-volumio volumio[27823]: info: ------------------------------------------- Nov 19 13:40:28 chris-volumio volumio[27823]: info: ----- System startup ---- Nov 19 13:40:28 chris-volumio volumio[27823]: info: ------------------------------------------- Nov 19 13:40:28 chris-volumio volumio[27823]: info: MYVOLUMIO Environment detected Nov 19 13:40:28 chris-volumio volumio[27823]: info: Plugin folders cleanup Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning category audio_interface Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning category miscellanea Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning category music_service Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning category plugins.json Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning category system_controller Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning category user_interface Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning into folder /data/plugins/ Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning category audio_interface Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning category music_service Nov 19 13:40:28 chris-volumio volumio[27823]: info: Scanning category user_interface Nov 19 13:40:28 chris-volumio volumio[27823]: info: Plugin folders cleanup completed Nov 19 13:40:28 chris-volumio volumio[27823]: info: ------------------------------------------- Nov 19 13:40:28 chris-volumio volumio[27823]: info: ----- Core plugins startup ---- Nov 19 13:40:28 chris-volumio volumio[27823]: info: ------------------------------------------- Nov 19 13:40:28 chris-volumio volumio[27823]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:40:28 chris-volumio volumio[27823]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:40:28 chris-volumio volumio[27823]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:40:28 chris-volumio volumio[27823]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:40:28 chris-volumio volumio[27823]: info: Loading plugins from folder /data/plugins/ Nov 19 13:40:28 chris-volumio volumio[27823]: info: Loading plugin "system"... Nov 19 13:40:28 chris-volumio volumio[27823]: info: Loading plugin "appearance"... Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "network"... Nov 19 13:40:29 chris-volumio volumio[27823]: info: Refreshing Cached IP Addresses Nov 19 13:40:29 chris-volumio sudo[27847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:40:29 chris-volumio sudo[27847]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:29 chris-volumio sudo[27847]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:29 chris-volumio sudo[27849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:40:29 chris-volumio sudo[27849]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "services"... Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "alsa_controller"... Nov 19 13:40:29 chris-volumio sudo[27849]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:29 chris-volumio sudo[27852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:40:29 chris-volumio sudo[27852]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:29 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "wizard"... Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "upnp"... Nov 19 13:40:29 chris-volumio volumio[27823]: info: [1700401229424] Starting Upmpd Daemon Nov 19 13:40:29 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "my_music"... Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "mpd"... Nov 19 13:40:29 chris-volumio volumio[27823]: info: Creating MPD Configuration file Nov 19 13:40:29 chris-volumio sudo[27858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:40:29 chris-volumio sudo[27858]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "upnp_browser"... Nov 19 13:40:29 chris-volumio sudo[27858]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:29 chris-volumio sudo[27860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:40:29 chris-volumio sudo[27860]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:29 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:40:29 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:40:29 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:40:29 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:40:29 chris-volumio volumio[27823]: info: Loading plugin "networkfs"... Nov 19 13:40:30 chris-volumio volumio[27823]: info: Starting Udev Watcher for removable devices Nov 19 13:40:30 chris-volumio sudo[27868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:40:30 chris-volumio sudo[27868]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:30 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:40:30 chris-volumio volumio[27823]: info: Ignoring mount for partition: boot Nov 19 13:40:30 chris-volumio volumio[27823]: info: Ignoring mount for partition: volumio Nov 19 13:40:30 chris-volumio volumio[27823]: info: Ignoring mount for partition: volumio_data Nov 19 13:40:30 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:30 chris-volumio volumio[27823]: info: Loading plugin "alarm-clock"... Nov 19 13:40:30 chris-volumio volumio[27823]: info: Loading plugin "airplay_emulation"... Nov 19 13:40:30 chris-volumio volumio[27823]: info: Starting Shairport Sync Nov 19 13:40:30 chris-volumio volumio[27823]: info: Loading plugin "last_100"... Nov 19 13:40:30 chris-volumio volumio[27823]: info: Loading plugin "webradio"... Nov 19 13:40:30 chris-volumio volumio[27823]: info: Loading plugin "i2s_dacs"... Nov 19 13:40:30 chris-volumio volumio[27823]: info: Loading plugin "volumiodiscovery"... Nov 19 13:40:30 chris-volumio volumio[27823]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:30 chris-volumio node[27823]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:30 chris-volumio node[27823]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:30 chris-volumio volumio[27823]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:30 chris-volumio volumio[27823]: *** WARNING *** For more information see Nov 19 13:40:30 chris-volumio volumio[27823]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:30 chris-volumio volumio[27823]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:30 chris-volumio volumio[27823]: *** WARNING *** For more information see Nov 19 13:40:30 chris-volumio node[27823]: *** WARNING *** For more information see Nov 19 13:40:30 chris-volumio node[27823]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:30 chris-volumio node[27823]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:30 chris-volumio node[27823]: *** WARNING *** For more information see Nov 19 13:40:30 chris-volumio volumio[27823]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:40:30 chris-volumio volumio[27823]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:40:30 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:30 chris-volumio volumio[27823]: info: Loading plugin "ytcr"... Nov 19 13:40:30 chris-volumio mpd[27865]: Nov 19 13:40 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:40:30 chris-volumio mpd[27865]: Nov 19 13:40 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:40:30 chris-volumio mpd[27865]: Nov 19 13:40 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:40:30 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:40:30 chris-volumio sudo[27860]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:31 chris-volumio sudo[27868]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:31 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:40:31 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 19 13:40:31 chris-volumio volumio[27823]: info: Loading plugin "now_playing"... Nov 19 13:40:31 chris-volumio volumio[27823]: info: Loading plugin "outputs"... Nov 19 13:40:31 chris-volumio volumio[27823]: info: Loading plugin "albumart"... Nov 19 13:40:31 chris-volumio volumio[27823]: info: Plugin example_plugin is not enabled Nov 19 13:40:31 chris-volumio volumio[27823]: info: Loading plugin "inputs"... Nov 19 13:40:31 chris-volumio volumio[27823]: info: Loading plugin "updater_comm"... Nov 19 13:40:31 chris-volumio volumio[27823]: info: Plugin mpdemulation is not enabled Nov 19 13:40:31 chris-volumio volumio[27823]: info: Loading plugin "rest_api"... Nov 19 13:40:31 chris-volumio volumio[27823]: info: Loading plugin "websocket"... Nov 19 13:40:31 chris-volumio volumio[27823]: info: Loading plugin "fusiondsp"... Nov 19 13:40:31 chris-volumio volumio[27823]: Forking 3 albumart workers Nov 19 13:40:31 chris-volumio sudo[27852]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:32 chris-volumio volumio[27823]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:40:32 chris-volumio volumio[27823]: info: Loading plugin "RoonBridge"... Nov 19 13:40:32 chris-volumio volumio[27823]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:40:32 chris-volumio volumio[27823]: info: Loading plugin "radio_paradise"... Nov 19 13:40:32 chris-volumio volumio[27823]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:40:32 chris-volumio volumio[27823]: info: [1700401232460] [RadioParadise] API delay: 5 Nov 19 13:40:32 chris-volumio volumio[27823]: info: Loading plugin "lastfm"... Nov 19 13:40:32 chris-volumio volumio[27823]: Starting albumart workers Nov 19 13:40:32 chris-volumio volumio[27823]: Starting albumart workers Nov 19 13:40:32 chris-volumio volumio[27823]: Starting albumart workers Nov 19 13:40:32 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:32] [connect] Successful connection Nov 19 13:40:32 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:32] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:40:32 chris-volumio volumio[27823]: info: Loading i18n strings for locale en Nov 19 13:40:32 chris-volumio volumio[27823]: Updating browse sources language Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::initPlayerControls Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:32 chris-volumio volumio[27823]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:32 chris-volumio volumio[27823]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:40:32 chris-volumio volumio[27823]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:40:32 chris-volumio volumio[27823]: at listenInCluster (net.js:1366:12) Nov 19 13:40:32 chris-volumio volumio[27823]: at Server.listen (net.js:1452:7) Nov 19 13:40:32 chris-volumio volumio[27823]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:40:32 chris-volumio volumio[27823]: at Object. (/volumio/index.js:26:29) Nov 19 13:40:32 chris-volumio volumio[27823]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:40:32 chris-volumio volumio[27823]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:40:32 chris-volumio volumio[27823]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:40:32 chris-volumio volumio[27823]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:40:32 chris-volumio volumio[27823]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:40:32 chris-volumio volumio[27823]: code: 'EADDRINUSE', Nov 19 13:40:32 chris-volumio volumio[27823]: errno: -98, Nov 19 13:40:32 chris-volumio volumio[27823]: syscall: 'listen', Nov 19 13:40:32 chris-volumio volumio[27823]: address: '::', Nov 19 13:40:32 chris-volumio volumio[27823]: port: 3000 Nov 19 13:40:32 chris-volumio volumio[27823]: } Nov 19 13:40:32 chris-volumio volumio[27823]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:33 chris-volumio sudo[27939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:39 Nov 19 13:40:33 chris-volumio sudo[27939]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:33 chris-volumio sudo[27939]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:33 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:40:33 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:40:33 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:33 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:33 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:40:33 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72980. Nov 19 13:40:33 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:40:34 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:40:34 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:34 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:35 chris-volumio volumio[27952]: info: ------------------------------------------- Nov 19 13:40:35 chris-volumio volumio[27952]: info: ----- Volumio3 ---- Nov 19 13:40:35 chris-volumio volumio[27952]: info: ------------------------------------------- Nov 19 13:40:35 chris-volumio volumio[27952]: info: ----- System startup ---- Nov 19 13:40:35 chris-volumio volumio[27952]: info: ------------------------------------------- Nov 19 13:40:35 chris-volumio volumio[27952]: info: MYVOLUMIO Environment detected Nov 19 13:40:35 chris-volumio volumio[27952]: info: Plugin folders cleanup Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning category audio_interface Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning category miscellanea Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning category music_service Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning category plugins.json Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning category system_controller Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning category user_interface Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning into folder /data/plugins/ Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning category audio_interface Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning category music_service Nov 19 13:40:35 chris-volumio volumio[27952]: info: Scanning category user_interface Nov 19 13:40:35 chris-volumio volumio[27952]: info: Plugin folders cleanup completed Nov 19 13:40:35 chris-volumio volumio[27952]: info: ------------------------------------------- Nov 19 13:40:35 chris-volumio volumio[27952]: info: ----- Core plugins startup ---- Nov 19 13:40:35 chris-volumio volumio[27952]: info: ------------------------------------------- Nov 19 13:40:35 chris-volumio volumio[27952]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:40:35 chris-volumio volumio[27952]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:40:35 chris-volumio volumio[27952]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:40:35 chris-volumio volumio[27952]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:40:35 chris-volumio volumio[27952]: info: Loading plugins from folder /data/plugins/ Nov 19 13:40:35 chris-volumio volumio[27952]: info: Loading plugin "system"... Nov 19 13:40:35 chris-volumio volumio[27952]: info: Loading plugin "appearance"... Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "network"... Nov 19 13:40:36 chris-volumio volumio[27952]: info: Refreshing Cached IP Addresses Nov 19 13:40:36 chris-volumio sudo[27976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:40:36 chris-volumio sudo[27976]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:36 chris-volumio sudo[27976]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:36 chris-volumio sudo[27978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:40:36 chris-volumio sudo[27978]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "services"... Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "alsa_controller"... Nov 19 13:40:36 chris-volumio sudo[27978]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:36 chris-volumio sudo[27981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:40:36 chris-volumio sudo[27981]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:36 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "wizard"... Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "upnp"... Nov 19 13:40:36 chris-volumio volumio[27952]: info: [1700401236154] Starting Upmpd Daemon Nov 19 13:40:36 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "my_music"... Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "mpd"... Nov 19 13:40:36 chris-volumio volumio[27952]: info: Creating MPD Configuration file Nov 19 13:40:36 chris-volumio sudo[27987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "upnp_browser"... Nov 19 13:40:36 chris-volumio sudo[27987]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:36 chris-volumio sudo[27987]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:36 chris-volumio sudo[27989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:40:36 chris-volumio sudo[27989]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:36 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:40:36 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:40:36 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:40:36 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "networkfs"... Nov 19 13:40:36 chris-volumio volumio[27952]: info: Starting Udev Watcher for removable devices Nov 19 13:40:36 chris-volumio sudo[27997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:40:36 chris-volumio sudo[27997]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:36 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:40:36 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:40:36 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 19 13:40:36 chris-volumio sudo[27997]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:36 chris-volumio volumio[27952]: info: Ignoring mount for partition: boot Nov 19 13:40:36 chris-volumio volumio[27952]: info: Ignoring mount for partition: volumio Nov 19 13:40:36 chris-volumio volumio[27952]: info: Ignoring mount for partition: volumio_data Nov 19 13:40:36 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:36 chris-volumio volumio[27952]: info: Loading plugin "alarm-clock"... Nov 19 13:40:37 chris-volumio volumio[27952]: info: Loading plugin "airplay_emulation"... Nov 19 13:40:37 chris-volumio volumio[27952]: info: Starting Shairport Sync Nov 19 13:40:37 chris-volumio volumio[27952]: info: Loading plugin "last_100"... Nov 19 13:40:37 chris-volumio volumio[27952]: info: Loading plugin "webradio"... Nov 19 13:40:37 chris-volumio volumio[27952]: info: Loading plugin "i2s_dacs"... Nov 19 13:40:37 chris-volumio volumio[27952]: info: Loading plugin "volumiodiscovery"... Nov 19 13:40:37 chris-volumio volumio[27952]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:37 chris-volumio node[27952]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:37 chris-volumio node[27952]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:37 chris-volumio volumio[27952]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:37 chris-volumio volumio[27952]: *** WARNING *** For more information see Nov 19 13:40:37 chris-volumio volumio[27952]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:37 chris-volumio volumio[27952]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:37 chris-volumio volumio[27952]: *** WARNING *** For more information see Nov 19 13:40:37 chris-volumio node[27952]: *** WARNING *** For more information see Nov 19 13:40:37 chris-volumio node[27952]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:37 chris-volumio node[27952]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:37 chris-volumio node[27952]: *** WARNING *** For more information see Nov 19 13:40:37 chris-volumio volumio[27952]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:40:37 chris-volumio volumio[27952]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:40:37 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:37 chris-volumio volumio[27952]: info: Loading plugin "ytcr"... Nov 19 13:40:37 chris-volumio mpd[27994]: Nov 19 13:40 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:40:37 chris-volumio mpd[27994]: Nov 19 13:40 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:40:37 chris-volumio mpd[27994]: Nov 19 13:40 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:40:37 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:40:37 chris-volumio sudo[27989]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "now_playing"... Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "outputs"... Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "albumart"... Nov 19 13:40:38 chris-volumio volumio[27952]: info: Plugin example_plugin is not enabled Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "inputs"... Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "updater_comm"... Nov 19 13:40:38 chris-volumio volumio[27952]: info: Plugin mpdemulation is not enabled Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "rest_api"... Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "websocket"... Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "fusiondsp"... Nov 19 13:40:38 chris-volumio volumio[27952]: Forking 3 albumart workers Nov 19 13:40:38 chris-volumio volumio[27952]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:40:38 chris-volumio sudo[27981]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "RoonBridge"... Nov 19 13:40:38 chris-volumio volumio[27952]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:40:38 chris-volumio volumio[27952]: info: Loading plugin "radio_paradise"... Nov 19 13:40:39 chris-volumio volumio[27952]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:40:39 chris-volumio volumio[27952]: info: [1700401239120] [RadioParadise] API delay: 5 Nov 19 13:40:39 chris-volumio volumio[27952]: info: Loading plugin "lastfm"... Nov 19 13:40:39 chris-volumio volumio[27952]: Starting albumart workers Nov 19 13:40:39 chris-volumio volumio[27952]: Starting albumart workers Nov 19 13:40:39 chris-volumio volumio[27952]: Starting albumart workers Nov 19 13:40:39 chris-volumio volumio[27952]: info: Loading i18n strings for locale en Nov 19 13:40:39 chris-volumio volumio[27952]: Updating browse sources language Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::initPlayerControls Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:39 chris-volumio volumio[27952]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:39 chris-volumio volumio[27952]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:40:39 chris-volumio volumio[27952]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:40:39 chris-volumio volumio[27952]: at listenInCluster (net.js:1366:12) Nov 19 13:40:39 chris-volumio volumio[27952]: at Server.listen (net.js:1452:7) Nov 19 13:40:39 chris-volumio volumio[27952]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:40:39 chris-volumio volumio[27952]: at Object. (/volumio/index.js:26:29) Nov 19 13:40:39 chris-volumio volumio[27952]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:40:39 chris-volumio volumio[27952]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:40:39 chris-volumio volumio[27952]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:40:39 chris-volumio volumio[27952]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:40:39 chris-volumio volumio[27952]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:40:39 chris-volumio volumio[27952]: code: 'EADDRINUSE', Nov 19 13:40:39 chris-volumio volumio[27952]: errno: -98, Nov 19 13:40:39 chris-volumio volumio[27952]: syscall: 'listen', Nov 19 13:40:39 chris-volumio volumio[27952]: address: '::', Nov 19 13:40:39 chris-volumio volumio[27952]: port: 3000 Nov 19 13:40:39 chris-volumio volumio[27952]: } Nov 19 13:40:39 chris-volumio volumio[27952]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:39 chris-volumio sudo[28067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:39 Nov 19 13:40:39 chris-volumio sudo[28067]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:40 chris-volumio sudo[28067]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:42 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:42] [connect] Successful connection Nov 19 13:40:42 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:42] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:40:46 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:40:46 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:40:46 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:46 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:46 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:40:46 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72981. Nov 19 13:40:46 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:40:46 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:40:46 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:46 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:47 chris-volumio volumio[28081]: info: ------------------------------------------- Nov 19 13:40:47 chris-volumio volumio[28081]: info: ----- Volumio3 ---- Nov 19 13:40:47 chris-volumio volumio[28081]: info: ------------------------------------------- Nov 19 13:40:47 chris-volumio volumio[28081]: info: ----- System startup ---- Nov 19 13:40:47 chris-volumio volumio[28081]: info: ------------------------------------------- Nov 19 13:40:48 chris-volumio volumio[28081]: info: MYVOLUMIO Environment detected Nov 19 13:40:48 chris-volumio volumio[28081]: info: Plugin folders cleanup Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning category audio_interface Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning category miscellanea Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning category music_service Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning category plugins.json Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning category system_controller Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning category user_interface Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning into folder /data/plugins/ Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning category audio_interface Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning category music_service Nov 19 13:40:48 chris-volumio volumio[28081]: info: Scanning category user_interface Nov 19 13:40:48 chris-volumio volumio[28081]: info: Plugin folders cleanup completed Nov 19 13:40:48 chris-volumio volumio[28081]: info: ------------------------------------------- Nov 19 13:40:48 chris-volumio volumio[28081]: info: ----- Core plugins startup ---- Nov 19 13:40:48 chris-volumio volumio[28081]: info: ------------------------------------------- Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:40:48 chris-volumio volumio[28081]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:40:48 chris-volumio volumio[28081]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:40:48 chris-volumio volumio[28081]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugins from folder /data/plugins/ Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "system"... Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "appearance"... Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "network"... Nov 19 13:40:48 chris-volumio volumio[28081]: info: Refreshing Cached IP Addresses Nov 19 13:40:48 chris-volumio sudo[28105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:40:48 chris-volumio sudo[28105]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:48 chris-volumio sudo[28105]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "services"... Nov 19 13:40:48 chris-volumio sudo[28107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:40:48 chris-volumio sudo[28107]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "alsa_controller"... Nov 19 13:40:48 chris-volumio sudo[28107]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:48 chris-volumio sudo[28110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:40:48 chris-volumio sudo[28110]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:48 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "wizard"... Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "upnp"... Nov 19 13:40:48 chris-volumio volumio[28081]: info: [1700401248902] Starting Upmpd Daemon Nov 19 13:40:48 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "my_music"... Nov 19 13:40:48 chris-volumio volumio[28081]: info: Loading plugin "mpd"... Nov 19 13:40:49 chris-volumio volumio[28081]: info: Creating MPD Configuration file Nov 19 13:40:49 chris-volumio sudo[28116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:40:49 chris-volumio sudo[28116]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:49 chris-volumio volumio[28081]: info: Loading plugin "upnp_browser"... Nov 19 13:40:49 chris-volumio sudo[28116]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:49 chris-volumio sudo[28118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:40:49 chris-volumio sudo[28118]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:49 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:40:49 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:40:49 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:40:49 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:40:49 chris-volumio volumio[28081]: info: Loading plugin "networkfs"... Nov 19 13:40:49 chris-volumio volumio[28081]: info: Starting Udev Watcher for removable devices Nov 19 13:40:49 chris-volumio sudo[28126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:40:49 chris-volumio sudo[28126]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:49 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:40:49 chris-volumio volumio[28081]: info: Ignoring mount for partition: boot Nov 19 13:40:49 chris-volumio volumio[28081]: info: Ignoring mount for partition: volumio Nov 19 13:40:49 chris-volumio volumio[28081]: info: Ignoring mount for partition: volumio_data Nov 19 13:40:49 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:49 chris-volumio volumio[28081]: info: Loading plugin "alarm-clock"... Nov 19 13:40:49 chris-volumio volumio[28081]: info: Loading plugin "airplay_emulation"... Nov 19 13:40:49 chris-volumio volumio[28081]: info: Starting Shairport Sync Nov 19 13:40:49 chris-volumio volumio[28081]: info: Loading plugin "last_100"... Nov 19 13:40:49 chris-volumio volumio[28081]: info: Loading plugin "webradio"... Nov 19 13:40:49 chris-volumio volumio[28081]: info: Loading plugin "i2s_dacs"... Nov 19 13:40:49 chris-volumio volumio[28081]: info: Loading plugin "volumiodiscovery"... Nov 19 13:40:49 chris-volumio volumio[28081]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:49 chris-volumio volumio[28081]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:49 chris-volumio node[28081]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:49 chris-volumio volumio[28081]: *** WARNING *** For more information see Nov 19 13:40:49 chris-volumio volumio[28081]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:49 chris-volumio volumio[28081]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:49 chris-volumio volumio[28081]: *** WARNING *** For more information see Nov 19 13:40:49 chris-volumio node[28081]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:49 chris-volumio node[28081]: *** WARNING *** For more information see Nov 19 13:40:49 chris-volumio node[28081]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:40:49 chris-volumio node[28081]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:40:49 chris-volumio node[28081]: *** WARNING *** For more information see Nov 19 13:40:49 chris-volumio volumio[28081]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:40:49 chris-volumio volumio[28081]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:40:49 chris-volumio mpd[28123]: Nov 19 13:40 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:40:49 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:40:49 chris-volumio volumio[28081]: info: Loading plugin "ytcr"... Nov 19 13:40:50 chris-volumio mpd[28123]: Nov 19 13:40 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:40:50 chris-volumio mpd[28123]: Nov 19 13:40 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:40:50 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:40:50 chris-volumio sudo[28118]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:50 chris-volumio volumio[28081]: info: Loading plugin "now_playing"... Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "outputs"... Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "albumart"... Nov 19 13:40:51 chris-volumio volumio[28081]: info: Plugin example_plugin is not enabled Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "inputs"... Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "updater_comm"... Nov 19 13:40:51 chris-volumio volumio[28081]: info: Plugin mpdemulation is not enabled Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "rest_api"... Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "websocket"... Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "fusiondsp"... Nov 19 13:40:51 chris-volumio volumio[28081]: Forking 3 albumart workers Nov 19 13:40:51 chris-volumio sudo[28110]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:51 chris-volumio volumio[28081]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "RoonBridge"... Nov 19 13:40:51 chris-volumio volumio[28081]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "radio_paradise"... Nov 19 13:40:51 chris-volumio volumio[28081]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:40:51 chris-volumio volumio[28081]: info: [1700401251904] [RadioParadise] API delay: 5 Nov 19 13:40:51 chris-volumio volumio[28081]: info: Loading plugin "lastfm"... Nov 19 13:40:51 chris-volumio volumio[28081]: Starting albumart workers Nov 19 13:40:51 chris-volumio volumio[28081]: Starting albumart workers Nov 19 13:40:52 chris-volumio volumio[28081]: Starting albumart workers Nov 19 13:40:52 chris-volumio volumio[28081]: info: Loading i18n strings for locale en Nov 19 13:40:52 chris-volumio volumio[28081]: Updating browse sources language Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::initPlayerControls Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:40:52 chris-volumio volumio[28081]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:52 chris-volumio volumio[28081]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:40:52 chris-volumio volumio[28081]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:40:52 chris-volumio volumio[28081]: at listenInCluster (net.js:1366:12) Nov 19 13:40:52 chris-volumio volumio[28081]: at Server.listen (net.js:1452:7) Nov 19 13:40:52 chris-volumio volumio[28081]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:40:52 chris-volumio volumio[28081]: at Object. (/volumio/index.js:26:29) Nov 19 13:40:52 chris-volumio volumio[28081]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:40:52 chris-volumio volumio[28081]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:40:52 chris-volumio volumio[28081]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:40:52 chris-volumio volumio[28081]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:40:52 chris-volumio volumio[28081]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:40:52 chris-volumio volumio[28081]: code: 'EADDRINUSE', Nov 19 13:40:52 chris-volumio volumio[28081]: errno: -98, Nov 19 13:40:52 chris-volumio volumio[28081]: syscall: 'listen', Nov 19 13:40:52 chris-volumio volumio[28081]: address: '::', Nov 19 13:40:52 chris-volumio volumio[28081]: port: 3000 Nov 19 13:40:52 chris-volumio volumio[28081]: } Nov 19 13:40:52 chris-volumio volumio[28081]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:40:52 chris-volumio sudo[28196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:39 Nov 19 13:40:52 chris-volumio sudo[28196]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:40:52 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:52] [connect] Successful connection Nov 19 13:40:52 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:40:52] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:40:52 chris-volumio sudo[28196]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:59 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:40:59 chris-volumio sudo[28126]: pam_unix(sudo:session): session closed for user root Nov 19 13:40:59 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:40:59 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:40:59 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -4 Nov 19 13:40:59 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:59 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:40:59 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:40:59 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72982. Nov 19 13:40:59 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:40:59 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:40:59 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:40:59 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:41:00 chris-volumio volumio[28209]: info: ------------------------------------------- Nov 19 13:41:00 chris-volumio volumio[28209]: info: ----- Volumio3 ---- Nov 19 13:41:00 chris-volumio volumio[28209]: info: ------------------------------------------- Nov 19 13:41:00 chris-volumio volumio[28209]: info: ----- System startup ---- Nov 19 13:41:00 chris-volumio volumio[28209]: info: ------------------------------------------- Nov 19 13:41:01 chris-volumio volumio[28209]: info: MYVOLUMIO Environment detected Nov 19 13:41:01 chris-volumio volumio[28209]: info: Plugin folders cleanup Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning category audio_interface Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning category miscellanea Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning category music_service Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning category plugins.json Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning category system_controller Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning category user_interface Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning into folder /data/plugins/ Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning category audio_interface Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning category music_service Nov 19 13:41:01 chris-volumio volumio[28209]: info: Scanning category user_interface Nov 19 13:41:01 chris-volumio volumio[28209]: info: Plugin folders cleanup completed Nov 19 13:41:01 chris-volumio volumio[28209]: info: ------------------------------------------- Nov 19 13:41:01 chris-volumio volumio[28209]: info: ----- Core plugins startup ---- Nov 19 13:41:01 chris-volumio volumio[28209]: info: ------------------------------------------- Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:41:01 chris-volumio volumio[28209]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:41:01 chris-volumio volumio[28209]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:41:01 chris-volumio volumio[28209]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugins from folder /data/plugins/ Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "system"... Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "appearance"... Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "network"... Nov 19 13:41:01 chris-volumio volumio[28209]: info: Refreshing Cached IP Addresses Nov 19 13:41:01 chris-volumio sudo[28233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:41:01 chris-volumio sudo[28233]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:01 chris-volumio sudo[28233]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:01 chris-volumio sudo[28235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:41:01 chris-volumio sudo[28235]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "services"... Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "alsa_controller"... Nov 19 13:41:01 chris-volumio sudo[28235]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:01 chris-volumio sudo[28238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:41:01 chris-volumio sudo[28238]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:01 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "wizard"... Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "upnp"... Nov 19 13:41:01 chris-volumio volumio[28209]: info: [1700401261900] Starting Upmpd Daemon Nov 19 13:41:01 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "my_music"... Nov 19 13:41:01 chris-volumio volumio[28209]: info: Loading plugin "mpd"... Nov 19 13:41:02 chris-volumio volumio[28209]: info: Creating MPD Configuration file Nov 19 13:41:02 chris-volumio sudo[28244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:41:02 chris-volumio volumio[28209]: info: Loading plugin "upnp_browser"... Nov 19 13:41:02 chris-volumio sudo[28244]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:02 chris-volumio sudo[28244]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:02 chris-volumio sudo[28246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:41:02 chris-volumio sudo[28246]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:02 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:41:02 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:41:02 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:41:02 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:41:02 chris-volumio volumio[28209]: info: Loading plugin "networkfs"... Nov 19 13:41:02 chris-volumio volumio[28209]: info: Starting Udev Watcher for removable devices Nov 19 13:41:02 chris-volumio sudo[28255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:41:02 chris-volumio sudo[28255]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:02 chris-volumio sudo[28255]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:02 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:41:02 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:41:02 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 19 13:41:02 chris-volumio volumio[28209]: info: Ignoring mount for partition: boot Nov 19 13:41:02 chris-volumio volumio[28209]: info: Ignoring mount for partition: volumio Nov 19 13:41:02 chris-volumio volumio[28209]: info: Ignoring mount for partition: volumio_data Nov 19 13:41:02 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:02 chris-volumio volumio[28209]: info: Loading plugin "alarm-clock"... Nov 19 13:41:02 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:41:02] [connect] Successful connection Nov 19 13:41:02 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:41:02] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:41:02 chris-volumio volumio[28209]: info: Loading plugin "airplay_emulation"... Nov 19 13:41:02 chris-volumio volumio[28209]: info: Starting Shairport Sync Nov 19 13:41:02 chris-volumio volumio[28209]: info: Loading plugin "last_100"... Nov 19 13:41:02 chris-volumio volumio[28209]: info: Loading plugin "webradio"... Nov 19 13:41:02 chris-volumio volumio[28209]: info: Loading plugin "i2s_dacs"... Nov 19 13:41:02 chris-volumio volumio[28209]: info: Loading plugin "volumiodiscovery"... Nov 19 13:41:02 chris-volumio volumio[28209]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:02 chris-volumio node[28209]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:02 chris-volumio node[28209]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:02 chris-volumio volumio[28209]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:02 chris-volumio volumio[28209]: *** WARNING *** For more information see Nov 19 13:41:02 chris-volumio volumio[28209]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:02 chris-volumio volumio[28209]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:02 chris-volumio volumio[28209]: *** WARNING *** For more information see Nov 19 13:41:02 chris-volumio node[28209]: *** WARNING *** For more information see Nov 19 13:41:02 chris-volumio node[28209]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:02 chris-volumio node[28209]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:02 chris-volumio node[28209]: *** WARNING *** For more information see Nov 19 13:41:02 chris-volumio volumio[28209]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:41:02 chris-volumio volumio[28209]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:41:02 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:02 chris-volumio volumio[28209]: info: Loading plugin "ytcr"... Nov 19 13:41:02 chris-volumio mpd[28252]: Nov 19 13:41 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:41:03 chris-volumio mpd[28252]: Nov 19 13:41 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:41:03 chris-volumio mpd[28252]: Nov 19 13:41 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:41:03 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:41:03 chris-volumio sudo[28246]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:03 chris-volumio volumio[28209]: info: Loading plugin "now_playing"... Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "outputs"... Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "albumart"... Nov 19 13:41:04 chris-volumio volumio[28209]: info: Plugin example_plugin is not enabled Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "inputs"... Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "updater_comm"... Nov 19 13:41:04 chris-volumio volumio[28209]: info: Plugin mpdemulation is not enabled Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "rest_api"... Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "websocket"... Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "fusiondsp"... Nov 19 13:41:04 chris-volumio volumio[28209]: Forking 3 albumart workers Nov 19 13:41:04 chris-volumio ntpd[672]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 19 13:41:04 chris-volumio sudo[28238]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:04 chris-volumio volumio[28209]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "RoonBridge"... Nov 19 13:41:04 chris-volumio volumio[28209]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "radio_paradise"... Nov 19 13:41:04 chris-volumio volumio[28209]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:41:04 chris-volumio volumio[28209]: info: [1700401264894] [RadioParadise] API delay: 5 Nov 19 13:41:04 chris-volumio volumio[28209]: info: Loading plugin "lastfm"... Nov 19 13:41:04 chris-volumio volumio[28209]: Starting albumart workers Nov 19 13:41:04 chris-volumio ntpd[672]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 19 13:41:04 chris-volumio volumio[28209]: Starting albumart workers Nov 19 13:41:05 chris-volumio volumio[28209]: Starting albumart workers Nov 19 13:41:05 chris-volumio volumio[28209]: info: Loading i18n strings for locale en Nov 19 13:41:05 chris-volumio volumio[28209]: Updating browse sources language Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::initPlayerControls Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:41:05 chris-volumio volumio[28209]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:41:05 chris-volumio volumio[28209]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:41:05 chris-volumio volumio[28209]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:41:05 chris-volumio volumio[28209]: at listenInCluster (net.js:1366:12) Nov 19 13:41:05 chris-volumio volumio[28209]: at Server.listen (net.js:1452:7) Nov 19 13:41:05 chris-volumio volumio[28209]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:41:05 chris-volumio volumio[28209]: at Object. (/volumio/index.js:26:29) Nov 19 13:41:05 chris-volumio volumio[28209]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:41:05 chris-volumio volumio[28209]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:41:05 chris-volumio volumio[28209]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:41:05 chris-volumio volumio[28209]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:41:05 chris-volumio volumio[28209]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:41:05 chris-volumio volumio[28209]: code: 'EADDRINUSE', Nov 19 13:41:05 chris-volumio volumio[28209]: errno: -98, Nov 19 13:41:05 chris-volumio volumio[28209]: syscall: 'listen', Nov 19 13:41:05 chris-volumio volumio[28209]: address: '::', Nov 19 13:41:05 chris-volumio volumio[28209]: port: 3000 Nov 19 13:41:05 chris-volumio volumio[28209]: } Nov 19 13:41:05 chris-volumio volumio[28209]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:41:05 chris-volumio sudo[28324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:40 Nov 19 13:41:05 chris-volumio sudo[28324]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:05 chris-volumio sudo[28324]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:11 chris-volumio ntpd[672]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 19 13:41:12 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:41:12] [connect] Successful connection Nov 19 13:41:12 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:41:12] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:41:13 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:41:13 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:41:13 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:41:13 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:41:13 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:41:13 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72983. Nov 19 13:41:13 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:41:13 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:41:13 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:41:13 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:41:14 chris-volumio volumio[28339]: info: ------------------------------------------- Nov 19 13:41:14 chris-volumio volumio[28339]: info: ----- Volumio3 ---- Nov 19 13:41:14 chris-volumio volumio[28339]: info: ------------------------------------------- Nov 19 13:41:14 chris-volumio volumio[28339]: info: ----- System startup ---- Nov 19 13:41:14 chris-volumio volumio[28339]: info: ------------------------------------------- Nov 19 13:41:14 chris-volumio volumio[28339]: info: MYVOLUMIO Environment detected Nov 19 13:41:14 chris-volumio volumio[28339]: info: Plugin folders cleanup Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning category audio_interface Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning category miscellanea Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning category music_service Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning category plugins.json Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning category system_controller Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning category user_interface Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning into folder /data/plugins/ Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning category audio_interface Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning category music_service Nov 19 13:41:14 chris-volumio volumio[28339]: info: Scanning category user_interface Nov 19 13:41:14 chris-volumio volumio[28339]: info: Plugin folders cleanup completed Nov 19 13:41:14 chris-volumio volumio[28339]: info: ------------------------------------------- Nov 19 13:41:14 chris-volumio volumio[28339]: info: ----- Core plugins startup ---- Nov 19 13:41:14 chris-volumio volumio[28339]: info: ------------------------------------------- Nov 19 13:41:14 chris-volumio volumio[28339]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:41:14 chris-volumio volumio[28339]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:41:14 chris-volumio volumio[28339]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:41:14 chris-volumio volumio[28339]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:41:14 chris-volumio volumio[28339]: info: Loading plugins from folder /data/plugins/ Nov 19 13:41:14 chris-volumio volumio[28339]: info: Loading plugin "system"... Nov 19 13:41:14 chris-volumio volumio[28339]: info: Loading plugin "appearance"... Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "network"... Nov 19 13:41:15 chris-volumio volumio[28339]: info: Refreshing Cached IP Addresses Nov 19 13:41:15 chris-volumio sudo[28363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:41:15 chris-volumio sudo[28363]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:15 chris-volumio sudo[28363]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:15 chris-volumio sudo[28365]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:41:15 chris-volumio sudo[28365]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "services"... Nov 19 13:41:15 chris-volumio sudo[28365]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "alsa_controller"... Nov 19 13:41:15 chris-volumio sudo[28368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:41:15 chris-volumio sudo[28368]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:15 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "wizard"... Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "upnp"... Nov 19 13:41:15 chris-volumio volumio[28339]: info: [1700401275369] Starting Upmpd Daemon Nov 19 13:41:15 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "my_music"... Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "mpd"... Nov 19 13:41:15 chris-volumio volumio[28339]: info: Creating MPD Configuration file Nov 19 13:41:15 chris-volumio sudo[28374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:41:15 chris-volumio sudo[28374]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "upnp_browser"... Nov 19 13:41:15 chris-volumio sudo[28374]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:15 chris-volumio sudo[28376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:41:15 chris-volumio sudo[28376]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:15 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:41:15 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:41:15 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:41:15 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:41:15 chris-volumio volumio[28339]: info: Loading plugin "networkfs"... Nov 19 13:41:15 chris-volumio volumio[28339]: info: Starting Udev Watcher for removable devices Nov 19 13:41:15 chris-volumio sudo[28384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:41:15 chris-volumio sudo[28384]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:15 chris-volumio sudo[28384]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:15 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:41:15 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:41:15 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 19 13:41:16 chris-volumio volumio[28339]: info: Ignoring mount for partition: boot Nov 19 13:41:16 chris-volumio volumio[28339]: info: Ignoring mount for partition: volumio Nov 19 13:41:16 chris-volumio volumio[28339]: info: Ignoring mount for partition: volumio_data Nov 19 13:41:16 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:16 chris-volumio volumio[28339]: info: Loading plugin "alarm-clock"... Nov 19 13:41:16 chris-volumio volumio[28339]: info: Loading plugin "airplay_emulation"... Nov 19 13:41:16 chris-volumio volumio[28339]: info: Starting Shairport Sync Nov 19 13:41:16 chris-volumio volumio[28339]: info: Loading plugin "last_100"... Nov 19 13:41:16 chris-volumio volumio[28339]: info: Loading plugin "webradio"... Nov 19 13:41:16 chris-volumio volumio[28339]: info: Loading plugin "i2s_dacs"... Nov 19 13:41:16 chris-volumio volumio[28339]: info: Loading plugin "volumiodiscovery"... Nov 19 13:41:16 chris-volumio volumio[28339]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:16 chris-volumio node[28339]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:16 chris-volumio node[28339]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:16 chris-volumio volumio[28339]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:16 chris-volumio volumio[28339]: *** WARNING *** For more information see Nov 19 13:41:16 chris-volumio volumio[28339]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:16 chris-volumio volumio[28339]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:16 chris-volumio volumio[28339]: *** WARNING *** For more information see Nov 19 13:41:16 chris-volumio node[28339]: *** WARNING *** For more information see Nov 19 13:41:16 chris-volumio node[28339]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:16 chris-volumio node[28339]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:16 chris-volumio node[28339]: *** WARNING *** For more information see Nov 19 13:41:16 chris-volumio volumio[28339]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:41:16 chris-volumio volumio[28339]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:41:16 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:16 chris-volumio volumio[28339]: info: Loading plugin "ytcr"... Nov 19 13:41:16 chris-volumio mpd[28381]: Nov 19 13:41 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:41:16 chris-volumio mpd[28381]: Nov 19 13:41 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:41:16 chris-volumio mpd[28381]: Nov 19 13:41 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:41:16 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:41:16 chris-volumio sudo[28376]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:17 chris-volumio volumio[28339]: info: Loading plugin "now_playing"... Nov 19 13:41:17 chris-volumio volumio[28339]: info: Loading plugin "outputs"... Nov 19 13:41:17 chris-volumio volumio[28339]: info: Loading plugin "albumart"... Nov 19 13:41:17 chris-volumio volumio[28339]: info: Plugin example_plugin is not enabled Nov 19 13:41:17 chris-volumio volumio[28339]: info: Loading plugin "inputs"... Nov 19 13:41:17 chris-volumio volumio[28339]: info: Loading plugin "updater_comm"... Nov 19 13:41:17 chris-volumio volumio[28339]: info: Plugin mpdemulation is not enabled Nov 19 13:41:17 chris-volumio volumio[28339]: info: Loading plugin "rest_api"... Nov 19 13:41:17 chris-volumio volumio[28339]: info: Loading plugin "websocket"... Nov 19 13:41:17 chris-volumio volumio[28339]: info: Loading plugin "fusiondsp"... Nov 19 13:41:17 chris-volumio volumio[28339]: Forking 3 albumart workers Nov 19 13:41:17 chris-volumio sudo[28368]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:17 chris-volumio volumio[28339]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:41:18 chris-volumio volumio[28339]: info: Loading plugin "RoonBridge"... Nov 19 13:41:18 chris-volumio volumio[28339]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:41:18 chris-volumio volumio[28339]: info: Loading plugin "radio_paradise"... Nov 19 13:41:18 chris-volumio volumio[28339]: Starting albumart workers Nov 19 13:41:18 chris-volumio volumio[28339]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:41:18 chris-volumio volumio[28339]: info: [1700401278365] [RadioParadise] API delay: 5 Nov 19 13:41:18 chris-volumio volumio[28339]: info: Loading plugin "lastfm"... Nov 19 13:41:18 chris-volumio volumio[28339]: Starting albumart workers Nov 19 13:41:18 chris-volumio volumio[28339]: Starting albumart workers Nov 19 13:41:18 chris-volumio volumio[28339]: info: Loading i18n strings for locale en Nov 19 13:41:18 chris-volumio volumio[28339]: Updating browse sources language Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::initPlayerControls Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:41:18 chris-volumio volumio[28339]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:41:18 chris-volumio volumio[28339]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:41:18 chris-volumio volumio[28339]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:41:18 chris-volumio volumio[28339]: at listenInCluster (net.js:1366:12) Nov 19 13:41:18 chris-volumio volumio[28339]: at Server.listen (net.js:1452:7) Nov 19 13:41:18 chris-volumio volumio[28339]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:41:18 chris-volumio volumio[28339]: at Object. (/volumio/index.js:26:29) Nov 19 13:41:18 chris-volumio volumio[28339]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:41:18 chris-volumio volumio[28339]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:41:18 chris-volumio volumio[28339]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:41:18 chris-volumio volumio[28339]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:41:18 chris-volumio volumio[28339]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:41:18 chris-volumio volumio[28339]: code: 'EADDRINUSE', Nov 19 13:41:18 chris-volumio volumio[28339]: errno: -98, Nov 19 13:41:18 chris-volumio volumio[28339]: syscall: 'listen', Nov 19 13:41:18 chris-volumio volumio[28339]: address: '::', Nov 19 13:41:18 chris-volumio volumio[28339]: port: 3000 Nov 19 13:41:18 chris-volumio volumio[28339]: } Nov 19 13:41:18 chris-volumio volumio[28339]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:41:19 chris-volumio sudo[28453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:40 Nov 19 13:41:19 chris-volumio sudo[28453]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:19 chris-volumio sudo[28453]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:22 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:41:22] [connect] Successful connection Nov 19 13:41:22 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:41:22] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:41:24 chris-volumio ntpd[672]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 19 13:41:25 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:41:25 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:41:25 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:41:25 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:41:25 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:41:25 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72984. Nov 19 13:41:25 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:41:25 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:41:25 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:41:25 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:41:26 chris-volumio volumio[28468]: info: ------------------------------------------- Nov 19 13:41:26 chris-volumio volumio[28468]: info: ----- Volumio3 ---- Nov 19 13:41:26 chris-volumio volumio[28468]: info: ------------------------------------------- Nov 19 13:41:26 chris-volumio volumio[28468]: info: ----- System startup ---- Nov 19 13:41:26 chris-volumio volumio[28468]: info: ------------------------------------------- Nov 19 13:41:27 chris-volumio dhcpcd[916]: eth0: NAK: from 192.168.68.1 Nov 19 13:41:27 chris-volumio volumio[28468]: info: MYVOLUMIO Environment detected Nov 19 13:41:27 chris-volumio volumio[28468]: info: Plugin folders cleanup Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning category audio_interface Nov 19 13:41:27 chris-volumio avahi-daemon[551]: Withdrawing address record for 192.168.68.65 on eth0. Nov 19 13:41:27 chris-volumio avahi-daemon[551]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.68.65. Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning category miscellanea Nov 19 13:41:27 chris-volumio avahi-daemon[551]: Interface eth0.IPv4 no longer relevant for mDNS. Nov 19 13:41:27 chris-volumio dhcpcd[916]: eth0: deleting route to 192.168.68.0/22 Nov 19 13:41:27 chris-volumio dhcpcd[916]: eth0: deleting default route via 192.168.68.1 Nov 19 13:41:27 chris-volumio dhcpcd[823]: eth0: pid 916 deleted IP address 192.168.68.65/22 Nov 19 13:41:27 chris-volumio dhcpcd[823]: eth0: deleting route to 192.168.68.0/22 Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning category music_service Nov 19 13:41:27 chris-volumio dhcpcd[823]: eth0: deleting default route via 192.168.68.1 Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning category plugins.json Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning category system_controller Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning category user_interface Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning into folder /data/plugins/ Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning category audio_interface Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning category music_service Nov 19 13:41:27 chris-volumio volumio[28468]: info: Scanning category user_interface Nov 19 13:41:27 chris-volumio volumio[28468]: info: Plugin folders cleanup completed Nov 19 13:41:27 chris-volumio volumio[28468]: info: ------------------------------------------- Nov 19 13:41:27 chris-volumio volumio[28468]: info: ----- Core plugins startup ---- Nov 19 13:41:27 chris-volumio volumio[28468]: info: ------------------------------------------- Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:41:27 chris-volumio volumio[28468]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:41:27 chris-volumio volumio[28468]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:41:27 chris-volumio volumio[28468]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugins from folder /data/plugins/ Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "system"... Nov 19 13:41:27 chris-volumio dhcpcd[916]: eth0: soliciting a DHCP lease Nov 19 13:41:27 chris-volumio dhcpcd[823]: eth0: rebinding lease of 192.168.68.65 Nov 19 13:41:27 chris-volumio dhcpcd[823]: eth0: NAK: from 192.168.68.1 Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "appearance"... Nov 19 13:41:27 chris-volumio dhcpcd[823]: eth0: soliciting a DHCP lease Nov 19 13:41:27 chris-volumio dhcpcd[916]: eth0: offered 192.168.68.65 from 192.168.68.1 Nov 19 13:41:27 chris-volumio dhcpcd[916]: eth0: NAK: from 192.168.68.1 Nov 19 13:41:27 chris-volumio dhcpcd[916]: eth0: NAK: from 192.168.68.1 Nov 19 13:41:27 chris-volumio dhcpcd[916]: eth0: probing address 192.168.68.65/22 Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "network"... Nov 19 13:41:27 chris-volumio volumio[28468]: info: Refreshing Cached IP Addresses Nov 19 13:41:27 chris-volumio sudo[28535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:41:27 chris-volumio sudo[28535]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:27 chris-volumio sudo[28535]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:27 chris-volumio sudo[28537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:41:27 chris-volumio sudo[28537]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "services"... Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "alsa_controller"... Nov 19 13:41:27 chris-volumio sudo[28537]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:27 chris-volumio sudo[28540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:41:27 chris-volumio sudo[28540]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:27 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "wizard"... Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "upnp"... Nov 19 13:41:27 chris-volumio volumio[28468]: info: [1700401287931] Starting Upmpd Daemon Nov 19 13:41:27 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "my_music"... Nov 19 13:41:27 chris-volumio volumio[28468]: info: Loading plugin "mpd"... Nov 19 13:41:28 chris-volumio volumio[28468]: info: Creating MPD Configuration file Nov 19 13:41:28 chris-volumio sudo[28546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:41:28 chris-volumio volumio[28468]: info: Loading plugin "upnp_browser"... Nov 19 13:41:28 chris-volumio sudo[28546]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:28 chris-volumio sudo[28546]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:28 chris-volumio sudo[28548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:41:28 chris-volumio sudo[28548]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:28 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:41:28 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:41:28 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:41:28 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:41:28 chris-volumio ntpd[672]: Deleting interface #5 eth0, 192.168.68.65#123, interface stats: received=0, sent=0, dropped=0, active_time=302400 secs Nov 19 13:41:28 chris-volumio volumio[28468]: info: Loading plugin "networkfs"... Nov 19 13:41:28 chris-volumio volumio[28468]: info: Starting Udev Watcher for removable devices Nov 19 13:41:28 chris-volumio sudo[28556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:41:28 chris-volumio sudo[28556]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:28 chris-volumio sudo[28556]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:28 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:41:28 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:41:28 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 19 13:41:28 chris-volumio volumio[28468]: info: Ignoring mount for partition: boot Nov 19 13:41:28 chris-volumio volumio[28468]: info: Ignoring mount for partition: volumio Nov 19 13:41:28 chris-volumio volumio[28468]: info: Ignoring mount for partition: volumio_data Nov 19 13:41:28 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:28 chris-volumio volumio[28468]: info: Loading plugin "alarm-clock"... Nov 19 13:41:28 chris-volumio volumio[28468]: info: Loading plugin "airplay_emulation"... Nov 19 13:41:28 chris-volumio volumio[28468]: info: Starting Shairport Sync Nov 19 13:41:28 chris-volumio volumio[28468]: info: Loading plugin "last_100"... Nov 19 13:41:28 chris-volumio volumio[28468]: info: Loading plugin "webradio"... Nov 19 13:41:28 chris-volumio volumio[28468]: info: Loading plugin "i2s_dacs"... Nov 19 13:41:28 chris-volumio volumio[28468]: info: Loading plugin "volumiodiscovery"... Nov 19 13:41:28 chris-volumio volumio[28468]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:28 chris-volumio volumio[28468]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:28 chris-volumio node[28468]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:28 chris-volumio volumio[28468]: *** WARNING *** For more information see Nov 19 13:41:28 chris-volumio volumio[28468]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:28 chris-volumio volumio[28468]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:28 chris-volumio volumio[28468]: *** WARNING *** For more information see Nov 19 13:41:28 chris-volumio node[28468]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:28 chris-volumio node[28468]: *** WARNING *** For more information see Nov 19 13:41:28 chris-volumio node[28468]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:28 chris-volumio node[28468]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:28 chris-volumio node[28468]: *** WARNING *** For more information see Nov 19 13:41:28 chris-volumio volumio[28468]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:41:28 chris-volumio volumio[28468]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:41:28 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:28 chris-volumio volumio[28468]: info: Loading plugin "ytcr"... Nov 19 13:41:29 chris-volumio mpd[28553]: Nov 19 13:41 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:41:29 chris-volumio mpd[28553]: Nov 19 13:41 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:41:29 chris-volumio mpd[28553]: Nov 19 13:41 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:41:29 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:41:29 chris-volumio sudo[28548]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:29 chris-volumio volumio[28468]: info: Loading plugin "now_playing"... Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "outputs"... Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "albumart"... Nov 19 13:41:30 chris-volumio volumio[28468]: info: Plugin example_plugin is not enabled Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "inputs"... Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "updater_comm"... Nov 19 13:41:30 chris-volumio volumio[28468]: info: Plugin mpdemulation is not enabled Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "rest_api"... Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "websocket"... Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "fusiondsp"... Nov 19 13:41:30 chris-volumio volumio[28468]: Forking 3 albumart workers Nov 19 13:41:30 chris-volumio sudo[28540]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:30 chris-volumio volumio[28468]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "RoonBridge"... Nov 19 13:41:30 chris-volumio volumio[28468]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "radio_paradise"... Nov 19 13:41:30 chris-volumio volumio[28468]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:41:30 chris-volumio volumio[28468]: info: [1700401290887] [RadioParadise] API delay: 5 Nov 19 13:41:30 chris-volumio volumio[28468]: info: Loading plugin "lastfm"... Nov 19 13:41:30 chris-volumio volumio[28468]: Starting albumart workers Nov 19 13:41:30 chris-volumio volumio[28468]: Starting albumart workers Nov 19 13:41:31 chris-volumio volumio[28468]: Starting albumart workers Nov 19 13:41:31 chris-volumio dhcpcd[823]: eth0: offered 192.168.68.61 from 192.168.68.1 Nov 19 13:41:31 chris-volumio dhcpcd[823]: eth0: ignoring offer of 192.168.68.65 from 192.168.68.1 Nov 19 13:41:31 chris-volumio dhcpcd[823]: eth0: probing address 192.168.68.61/22 Nov 19 13:41:31 chris-volumio volumio[28468]: info: Loading i18n strings for locale en Nov 19 13:41:31 chris-volumio volumio[28468]: Updating browse sources language Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::initPlayerControls Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:41:31 chris-volumio volumio[28468]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:41:31 chris-volumio volumio[28468]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:41:31 chris-volumio volumio[28468]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:41:31 chris-volumio volumio[28468]: at listenInCluster (net.js:1366:12) Nov 19 13:41:31 chris-volumio volumio[28468]: at Server.listen (net.js:1452:7) Nov 19 13:41:31 chris-volumio volumio[28468]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:41:31 chris-volumio volumio[28468]: at Object. (/volumio/index.js:26:29) Nov 19 13:41:31 chris-volumio volumio[28468]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:41:31 chris-volumio volumio[28468]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:41:31 chris-volumio volumio[28468]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:41:31 chris-volumio volumio[28468]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:41:31 chris-volumio volumio[28468]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:41:31 chris-volumio volumio[28468]: code: 'EADDRINUSE', Nov 19 13:41:31 chris-volumio volumio[28468]: errno: -98, Nov 19 13:41:31 chris-volumio volumio[28468]: syscall: 'listen', Nov 19 13:41:31 chris-volumio volumio[28468]: address: '::', Nov 19 13:41:31 chris-volumio volumio[28468]: port: 3000 Nov 19 13:41:31 chris-volumio volumio[28468]: } Nov 19 13:41:31 chris-volumio volumio[28468]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:41:31 chris-volumio sudo[28625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:40 Nov 19 13:41:31 chris-volumio sudo[28625]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:31 chris-volumio sudo[28625]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:31 chris-volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 19 13:41:31 chris-volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 19 13:41:31 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:41:31 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:41:32 chris-volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 19 13:41:32 chris-volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 72985. Nov 19 13:41:32 chris-volumio systemd[1]: Stopped Volumio Backend Module. Nov 19 13:41:32 chris-volumio systemd[1]: Started Volumio Backend Module. Nov 19 13:41:32 chris-volumio systemd[1]: Started dynamicswap service. Nov 19 13:41:32 chris-volumio systemd[1]: dynamicswap.service: Succeeded. Nov 19 13:41:32 chris-volumio dhcpcd[916]: eth0: leased 192.168.68.65 for 7200 seconds Nov 19 13:41:32 chris-volumio dhcpcd[916]: eth0: adding route to 192.168.68.0/22 Nov 19 13:41:32 chris-volumio dhcpcd[916]: eth0: adding default route via 192.168.68.1 Nov 19 13:41:32 chris-volumio avahi-daemon[551]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.68.65. Nov 19 13:41:32 chris-volumio avahi-daemon[551]: New relevant interface eth0.IPv4 for mDNS. Nov 19 13:41:32 chris-volumio avahi-daemon[551]: Registering new address record for 192.168.68.65 on eth0.IPv4. Nov 19 13:41:32 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:41:32] [connect] Successful connection Nov 19 13:41:32 chris-volumio volumio-remote-updater[546]: [2023-11-19 13:41:32] [error] Server handshake response error: websocketpp.processor:20 (Invalid HTTP status.) Nov 19 13:41:33 chris-volumio volumio[28638]: info: ------------------------------------------- Nov 19 13:41:33 chris-volumio volumio[28638]: info: ----- Volumio3 ---- Nov 19 13:41:33 chris-volumio volumio[28638]: info: ------------------------------------------- Nov 19 13:41:33 chris-volumio volumio[28638]: info: ----- System startup ---- Nov 19 13:41:33 chris-volumio volumio[28638]: info: ------------------------------------------- Nov 19 13:41:33 chris-volumio volumio[28638]: info: MYVOLUMIO Environment detected Nov 19 13:41:33 chris-volumio volumio[28638]: info: Plugin folders cleanup Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning into folder /volumio/app/plugins/ Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning category audio_interface Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning category miscellanea Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning category music_service Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning category plugins.json Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning category system_controller Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning category user_interface Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning into folder /data/plugins/ Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning category audio_interface Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning category music_service Nov 19 13:41:33 chris-volumio volumio[28638]: info: Scanning category user_interface Nov 19 13:41:33 chris-volumio volumio[28638]: info: Plugin folders cleanup completed Nov 19 13:41:33 chris-volumio volumio[28638]: info: ------------------------------------------- Nov 19 13:41:33 chris-volumio volumio[28638]: info: ----- Core plugins startup ---- Nov 19 13:41:33 chris-volumio volumio[28638]: info: ------------------------------------------- Nov 19 13:41:33 chris-volumio volumio[28638]: info: Loading plugins from folder /volumio/app/plugins/ Nov 19 13:41:33 chris-volumio volumio[28638]: info: Adding plugin upnp to MyMusic Plugins Nov 19 13:41:33 chris-volumio volumio[28638]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 19 13:41:33 chris-volumio volumio[28638]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 19 13:41:33 chris-volumio volumio[28638]: info: Loading plugins from folder /data/plugins/ Nov 19 13:41:33 chris-volumio volumio[28638]: info: Loading plugin "system"... Nov 19 13:41:33 chris-volumio volumio[28638]: info: Loading plugin "appearance"... Nov 19 13:41:34 chris-volumio ntpd[672]: Listen normally on 6 eth0 192.168.68.65:123 Nov 19 13:41:34 chris-volumio ntpd[672]: new interface(s) found: waking up resolver Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "network"... Nov 19 13:41:34 chris-volumio volumio[28638]: info: Refreshing Cached IP Addresses Nov 19 13:41:34 chris-volumio sudo[28682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 19 13:41:34 chris-volumio nmbd[651]: [2023/11/19 13:41:34.331648, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Nov 19 13:41:34 chris-volumio nmbd[651]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.68.65 for name WORKGROUP<1d>. Nov 19 13:41:34 chris-volumio nmbd[651]: This response was from IP 192.168.68.60, reporting an IP address of 192.168.68.60. Nov 19 13:41:34 chris-volumio sudo[28682]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:34 chris-volumio sudo[28682]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:34 chris-volumio sudo[28685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 19 13:41:34 chris-volumio sudo[28685]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "services"... Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "alsa_controller"... Nov 19 13:41:34 chris-volumio sudo[28685]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:34 chris-volumio sudo[28688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 19 13:41:34 chris-volumio sudo[28688]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:34 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "wizard"... Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "volumio_command_line_client"... Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "upnp"... Nov 19 13:41:34 chris-volumio volumio[28638]: info: [1700401294409] Starting Upmpd Daemon Nov 19 13:41:34 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "my_music"... Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "mpd"... Nov 19 13:41:34 chris-volumio volumio[28638]: info: Creating MPD Configuration file Nov 19 13:41:34 chris-volumio sudo[28694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "upnp_browser"... Nov 19 13:41:34 chris-volumio sudo[28694]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:34 chris-volumio sudo[28694]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:34 chris-volumio sudo[28696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 19 13:41:34 chris-volumio sudo[28696]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:34 chris-volumio systemd[1]: Stopping Music Player Daemon... Nov 19 13:41:34 chris-volumio systemd[1]: mpd.service: Succeeded. Nov 19 13:41:34 chris-volumio systemd[1]: Stopped Music Player Daemon. Nov 19 13:41:34 chris-volumio systemd[1]: Starting Music Player Daemon... Nov 19 13:41:34 chris-volumio volumio[28638]: info: Loading plugin "networkfs"... Nov 19 13:41:34 chris-volumio volumio[28638]: info: Starting Udev Watcher for removable devices Nov 19 13:41:34 chris-volumio sudo[28704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=chrisfox@ymail.com,password=cx7euaIfF3V8,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.22/Music /mnt/NAS/Music Nov 19 13:41:34 chris-volumio sudo[28704]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:35 chris-volumio kernel: CIFS: Attempting to mount \\192.168.1.22\Music Nov 19 13:41:35 chris-volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 19 13:41:35 chris-volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Nov 19 13:41:35 chris-volumio sudo[28704]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:35 chris-volumio volumio[28638]: info: Ignoring mount for partition: boot Nov 19 13:41:35 chris-volumio volumio[28638]: info: Ignoring mount for partition: volumio Nov 19 13:41:35 chris-volumio volumio[28638]: info: Ignoring mount for partition: volumio_data Nov 19 13:41:35 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:35 chris-volumio volumio[28638]: info: Loading plugin "alarm-clock"... Nov 19 13:41:35 chris-volumio volumio[28638]: info: Loading plugin "airplay_emulation"... Nov 19 13:41:35 chris-volumio volumio[28638]: info: Starting Shairport Sync Nov 19 13:41:35 chris-volumio volumio[28638]: info: Loading plugin "last_100"... Nov 19 13:41:35 chris-volumio volumio[28638]: info: Loading plugin "webradio"... Nov 19 13:41:35 chris-volumio volumio[28638]: info: Loading plugin "i2s_dacs"... Nov 19 13:41:35 chris-volumio volumio[28638]: info: Loading plugin "volumiodiscovery"... Nov 19 13:41:35 chris-volumio volumio[28638]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:35 chris-volumio node[28638]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:35 chris-volumio node[28638]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:35 chris-volumio volumio[28638]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:35 chris-volumio volumio[28638]: *** WARNING *** For more information see Nov 19 13:41:35 chris-volumio volumio[28638]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:35 chris-volumio volumio[28638]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:35 chris-volumio volumio[28638]: *** WARNING *** For more information see Nov 19 13:41:35 chris-volumio node[28638]: *** WARNING *** For more information see Nov 19 13:41:35 chris-volumio node[28638]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 19 13:41:35 chris-volumio node[28638]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 19 13:41:35 chris-volumio node[28638]: *** WARNING *** For more information see Nov 19 13:41:35 chris-volumio volumio[28638]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 19 13:41:35 chris-volumio volumio[28638]: info: Discovery: Started advertising with name: Chris-Volumio Nov 19 13:41:35 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 19 13:41:35 chris-volumio volumio[28638]: info: Loading plugin "ytcr"... Nov 19 13:41:35 chris-volumio mpd[28701]: Nov 19 13:41 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 19 13:41:35 chris-volumio mpd[28701]: Nov 19 13:41 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Nov 19 13:41:35 chris-volumio mpd[28701]: Nov 19 13:41 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Nov 19 13:41:35 chris-volumio systemd[1]: Started Music Player Daemon. Nov 19 13:41:35 chris-volumio sudo[28696]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:36 chris-volumio volumio[28638]: info: Loading plugin "now_playing"... Nov 19 13:41:36 chris-volumio volumio[28638]: info: Loading plugin "outputs"... Nov 19 13:41:36 chris-volumio volumio[28638]: info: Loading plugin "albumart"... Nov 19 13:41:36 chris-volumio volumio[28638]: info: Plugin example_plugin is not enabled Nov 19 13:41:36 chris-volumio volumio[28638]: info: Loading plugin "inputs"... Nov 19 13:41:36 chris-volumio volumio[28638]: info: Loading plugin "updater_comm"... Nov 19 13:41:36 chris-volumio volumio[28638]: info: Plugin mpdemulation is not enabled Nov 19 13:41:36 chris-volumio volumio[28638]: info: Loading plugin "rest_api"... Nov 19 13:41:36 chris-volumio volumio[28638]: info: Loading plugin "websocket"... Nov 19 13:41:36 chris-volumio volumio[28638]: info: Loading plugin "fusiondsp"... Nov 19 13:41:36 chris-volumio volumio[28638]: Forking 3 albumart workers Nov 19 13:41:36 chris-volumio dhcpcd[823]: eth0: leased 192.168.68.61 for 60 seconds Nov 19 13:41:36 chris-volumio dhcpcd[823]: eth0: adding route to 192.168.68.0/22 Nov 19 13:41:36 chris-volumio dhcpcd[823]: eth0: adding default route via 192.168.68.1 Nov 19 13:41:36 chris-volumio avahi-daemon[551]: Registering new address record for 192.168.68.61 on eth0.IPv4. Nov 19 13:41:36 chris-volumio sudo[28688]: pam_unix(sudo:session): session closed for user root Nov 19 13:41:36 chris-volumio volumio[28638]: info: Applying required configuration parameters for plugin fusiondsp Nov 19 13:41:37 chris-volumio volumio[28638]: info: Loading plugin "RoonBridge"... Nov 19 13:41:37 chris-volumio volumio[28638]: info: Applying required configuration parameters for plugin RoonBridge Nov 19 13:41:37 chris-volumio volumio[28638]: info: Loading plugin "radio_paradise"... Nov 19 13:41:37 chris-volumio volumio[28638]: info: Applying required configuration parameters for plugin radio_paradise Nov 19 13:41:37 chris-volumio volumio[28638]: info: [1700401297406] [RadioParadise] API delay: 5 Nov 19 13:41:37 chris-volumio volumio[28638]: info: Loading plugin "lastfm"... Nov 19 13:41:37 chris-volumio volumio[28638]: Starting albumart workers Nov 19 13:41:37 chris-volumio volumio[28638]: Starting albumart workers Nov 19 13:41:37 chris-volumio volumio[28638]: Starting albumart workers Nov 19 13:41:37 chris-volumio volumio[28638]: info: Loading i18n strings for locale en Nov 19 13:41:37 chris-volumio volumio[28638]: Updating browse sources language Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::initPlayerControls Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 19 13:41:37 chris-volumio volumio[28638]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:41:37 chris-volumio volumio[28638]: Error: listen EADDRINUSE: address already in use :::3000 Nov 19 13:41:37 chris-volumio volumio[28638]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Nov 19 13:41:37 chris-volumio volumio[28638]: at listenInCluster (net.js:1366:12) Nov 19 13:41:37 chris-volumio volumio[28638]: at Server.listen (net.js:1452:7) Nov 19 13:41:37 chris-volumio volumio[28638]: at Function.listen (/volumio/node_modules/express/lib/application.js:618:24) Nov 19 13:41:37 chris-volumio volumio[28638]: at Object. (/volumio/index.js:26:29) Nov 19 13:41:37 chris-volumio volumio[28638]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Nov 19 13:41:37 chris-volumio volumio[28638]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Nov 19 13:41:37 chris-volumio volumio[28638]: at Module.load (internal/modules/cjs/loader.js:928:32) Nov 19 13:41:37 chris-volumio volumio[28638]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Nov 19 13:41:37 chris-volumio volumio[28638]: at Function.executeUserEntryPoint [as runMain] (internal/modules/run_main.js:72:12) { Nov 19 13:41:37 chris-volumio volumio[28638]: code: 'EADDRINUSE', Nov 19 13:41:37 chris-volumio volumio[28638]: errno: -98, Nov 19 13:41:37 chris-volumio volumio[28638]: syscall: 'listen', Nov 19 13:41:37 chris-volumio volumio[28638]: address: '::', Nov 19 13:41:37 chris-volumio volumio[28638]: port: 3000 Nov 19 13:41:37 chris-volumio volumio[28638]: } Nov 19 13:41:37 chris-volumio volumio[28638]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 19 13:41:38 chris-volumio sudo[28792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-19 13:40 Nov 19 13:41:38 chris-volumio sudo[28792]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 19 13:41:38 chris-volumio ntpd[672]: Listen normally on 7 eth0 192.168.68.61:123 Nov 19 13:41:38 chris-volumio ntpd[672]: new interface(s) found: waking up resolver 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="893d2e91c55a7857b58762e70c2f65b9d163562b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST" VOLUMIO_VERSION="3.569" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"