-- Logs begin at Wed 2025-09-03 19:05:43 UTC, end at Fri 2026-10-16 16:39:48 UTC. -- Oct 16 16:39:17 volumio_streamer systemd[1]: Time has been changed Oct 16 16:39:17 volumio_streamer wireless.js[852]: trying... Oct 16 16:39:17 volumio_streamer sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 16:39:17 volumio_streamer sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:17 volumio_streamer sudo[1089]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:18 volumio_streamer wireless.js[852]: trying... Oct 16 16:39:18 volumio_streamer sudo[1099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 16:39:18 volumio_streamer sudo[1099]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:18 volumio_streamer sudo[1099]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:19 volumio_streamer wireless.js[852]: trying... Oct 16 16:39:19 volumio_streamer sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 16:39:19 volumio_streamer sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:19 volumio_streamer sudo[1108]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:20 volumio_streamer wireless.js[852]: trying... Oct 16 16:39:20 volumio_streamer sudo[1117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 16:39:20 volumio_streamer sudo[1117]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:20 volumio_streamer sudo[1117]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:21 volumio_streamer wireless.js[852]: trying... Oct 16 16:39:21 volumio_streamer sudo[1126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 16:39:21 volumio_streamer sudo[1126]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:21 volumio_streamer sudo[1126]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: wlan0: soliciting a DHCP lease Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: wlan0: offered 192.168.0.13 from 192.168.0.1 Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: wlan0: leased 192.168.0.13 for 86400 seconds Oct 16 16:39:22 volumio_streamer avahi-daemon[775]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.13. Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: eth0: adding route to 192.168.0.0/24 Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: eth0: adding default route via 192.168.0.1 Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: wlan0: adding host route to 192.168.0.13 via 127.0.0.1 Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: wlan0: adding route to 192.168.0.0/24 Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: wlan0: adding default route via 192.168.0.1 Oct 16 16:39:22 volumio_streamer avahi-daemon[775]: New relevant interface wlan0.IPv4 for mDNS. Oct 16 16:39:22 volumio_streamer avahi-daemon[775]: Registering new address record for 192.168.0.13 on wlan0.IPv4. Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: eth0: removing route to 192.168.0.0/24 Oct 16 16:39:22 volumio_streamer dhcpcd[1049]: eth0: removing default route via 192.168.0.1 Oct 16 16:39:22 volumio_streamer wireless.js[852]: trying... Oct 16 16:39:23 volumio_streamer sudo[1157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 16:39:23 volumio_streamer sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:23 volumio_streamer sudo[1157]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:23 volumio_streamer wireless.js[852]: Connected to: ----VM1962922 Oct 16 16:39:23 volumio_streamer wireless.js[852]: ---- Oct 16 16:39:23 volumio_streamer sudo[1166]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 16:39:23 volumio_streamer sudo[1166]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:23 volumio_streamer sudo[1166]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:23 volumio_streamer wireless.js[852]: ... joined AP, wlan0 IPv4 is 192.168.0.13, ipV6 is undefined Oct 16 16:39:23 volumio_streamer wireless.js[852]: It's done! AP Oct 16 16:39:23 volumio_streamer systemd[1]: Started Wireless Services. Oct 16 16:39:23 volumio_streamer systemd[1]: Starting Volumio Backend Module... Oct 16 16:39:23 volumio_streamer systemd[1]: Started Volumio Backend Module. Oct 16 16:39:23 volumio_streamer systemd[1]: Starting Volumio Streaming Daemon... Oct 16 16:39:23 volumio_streamer systemd[1]: Started Volumio Streaming Daemon. Oct 16 16:39:23 volumio_streamer systemd[1]: Starting Multi-User System. Oct 16 16:39:23 volumio_streamer systemd[1]: Reached target Multi-User System. Oct 16 16:39:23 volumio_streamer systemd[1]: Starting Graphical Interface. Oct 16 16:39:23 volumio_streamer systemd[1]: Reached target Graphical Interface. Oct 16 16:39:23 volumio_streamer systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 16 16:39:23 volumio_streamer systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 16 16:39:23 volumio_streamer systemd[1]: Startup finished in 9.952s (kernel) + 24.324s (userspace) = 34.277s. Oct 16 16:39:23 volumio_streamer volumio-streaming-daemon[1176]: ############################ Oct 16 16:39:23 volumio_streamer volumio-streaming-daemon[1176]: # Volumio Streaming Daemon # Oct 16 16:39:23 volumio_streamer volumio-streaming-daemon[1176]: # Running on port 7777 # Oct 16 16:39:23 volumio_streamer volumio-streaming-daemon[1176]: ############################ Oct 16 16:39:23 volumio_streamer volumio-streaming-daemon[1176]: Environment: production Oct 16 16:39:23 volumio_streamer ntpd[837]: Listen normally on 4 wlan0 192.168.0.13 UDP 123 Oct 16 16:39:23 volumio_streamer ntpd[837]: peers refreshed Oct 16 16:39:24 volumio_streamer volumio-remote-updater[702]: [2026-10-16 16:39:24] [info] asio async_connect error: system:111 (Connection refused) Oct 16 16:39:24 volumio_streamer volumio-remote-updater[702]: [2026-10-16 16:39:24] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 16 16:39:24 volumio_streamer volumio-remote-updater[702]: [2026-10-16 16:39:24] [error] handle_connect error: Underlying Transport Error Oct 16 16:39:25 volumio_streamer volumio[1175]: info: ------------------------------------------- Oct 16 16:39:25 volumio_streamer volumio[1175]: info: ----- Volumio2 ---- Oct 16 16:39:25 volumio_streamer volumio[1175]: info: ------------------------------------------- Oct 16 16:39:25 volumio_streamer volumio[1175]: info: ----- System startup ---- Oct 16 16:39:25 volumio_streamer volumio[1175]: info: ------------------------------------------- Oct 16 16:39:27 volumio_streamer volumio[1175]: info: MYVOLUMIO Environment detected Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Plugin folders cleanup Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Scanning into folder /volumio/app/plugins/ Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Scanning category audio_interface Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Scanning category miscellanea Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Scanning category music_service Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Scanning category plugins.json Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Scanning category system_controller Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Scanning category user_interface Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Scanning into folder /data/plugins/ Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Scanning category music_service Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Plugin folders cleanup completed Oct 16 16:39:27 volumio_streamer volumio[1175]: info: ------------------------------------------- Oct 16 16:39:27 volumio_streamer volumio[1175]: info: ----- Core plugins startup ---- Oct 16 16:39:27 volumio_streamer volumio[1175]: info: ------------------------------------------- Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Loading plugins from folder /volumio/app/plugins/ Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Adding plugin upnp to MyMusic Plugins Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Loading plugins from folder /data/plugins/ Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Loading plugin "system"... Oct 16 16:39:27 volumio_streamer volumio[1175]: info: Loading plugin "appearance"... Oct 16 16:39:28 volumio_streamer volumio[1175]: info: Loading plugin "network"... Oct 16 16:39:28 volumio_streamer volumio[1175]: info: Refreshing Cached IP Addresses Oct 16 16:39:28 volumio_streamer sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 16:39:28 volumio_streamer volumio[1175]: info: Loading plugin "services"... Oct 16 16:39:28 volumio_streamer volumio[1175]: info: Loading plugin "alsa_controller"... Oct 16 16:39:28 volumio_streamer sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:28 volumio_streamer sudo[1204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 16:39:28 volumio_streamer sudo[1201]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:28 volumio_streamer sudo[1204]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:28 volumio_streamer sudo[1204]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:28 volumio_streamer volumio[1175]: info: Loading plugin "wizard"... Oct 16 16:39:28 volumio_streamer volumio[1175]: info: Loading plugin "volumio_command_line_client"... Oct 16 16:39:29 volumio_streamer volumio[1175]: info: Loading plugin "upnp"... Oct 16 16:39:29 volumio_streamer volumio[1175]: info: [1792168769013] Starting Upmpd Daemon Oct 16 16:39:29 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 16:39:29 volumio_streamer volumio[1175]: info: Loading plugin "my_music"... Oct 16 16:39:29 volumio_streamer volumio[1175]: info: Loading plugin "mpd"... Oct 16 16:39:29 volumio_streamer volumio[1175]: info: Loading plugin "upnp_browser"... Oct 16 16:39:30 volumio_streamer volumio[1175]: info: Loading plugin "networkfs"... Oct 16 16:39:30 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 16:39:30 volumio_streamer volumio[1175]: info: Loading plugin "alarm-clock"... Oct 16 16:39:30 volumio_streamer sudo[1227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Clement,password=DiskM345!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.200/Music /mnt/NAS/NASDrive Oct 16 16:39:30 volumio_streamer sudo[1227]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:30 volumio_streamer kernel: FS-Cache: Netfs 'cifs' registered for caching Oct 16 16:39:30 volumio_streamer kernel: Key type cifs.spnego registered Oct 16 16:39:30 volumio_streamer kernel: Key type cifs.idmap registered Oct 16 16:39:30 volumio_streamer kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. Oct 16 16:39:30 volumio_streamer volumio[1175]: info: Loading plugin "airplay_emulation"... Oct 16 16:39:30 volumio_streamer volumio[1175]: info: Starting Shairport Sync Oct 16 16:39:30 volumio_streamer volumio[1175]: info: Loading plugin "last_100"... Oct 16 16:39:30 volumio_streamer volumio[1175]: info: Loading plugin "webradio"... Oct 16 16:39:30 volumio_streamer volumio[1175]: info: Loading plugin "i2s_dacs"... Oct 16 16:39:30 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:39:30 volumio_streamer volumio[1175]: info: Loading plugin "volumiodiscovery"... Oct 16 16:39:30 volumio_streamer volumio[1175]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 16:39:30 volumio_streamer node[1175]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 16:39:30 volumio_streamer node[1175]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:39:30 volumio_streamer node[1175]: *** WARNING *** For more information see Oct 16 16:39:30 volumio_streamer node[1175]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 16:39:30 volumio_streamer node[1175]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:39:30 volumio_streamer node[1175]: *** WARNING *** For more information see Oct 16 16:39:30 volumio_streamer volumio[1175]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:39:30 volumio_streamer volumio[1175]: *** WARNING *** For more information see Oct 16 16:39:30 volumio_streamer volumio[1175]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 16:39:30 volumio_streamer volumio[1175]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 16:39:30 volumio_streamer volumio[1175]: *** WARNING *** For more information see Oct 16 16:39:30 volumio_streamer volumio[1175]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 16 16:39:30 volumio_streamer volumio[1175]: Discovery: StartAdv! undefined Oct 16 16:39:30 volumio_streamer volumio[1175]: Discovery: Started advertising... Volumiostreamer - undefined Oct 16 16:39:30 volumio_streamer sudo[1227]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:31 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 16:39:31 volumio_streamer volumio[1175]: info: Loading plugin "outputs"... Oct 16 16:39:31 volumio_streamer volumio[1175]: info: Loading plugin "albumart"... Oct 16 16:39:31 volumio_streamer volumio[1175]: info: Plugin example_plugin is not enabled Oct 16 16:39:31 volumio_streamer volumio[1175]: info: Loading plugin "inputs"... Oct 16 16:39:31 volumio_streamer volumio[1175]: info: Loading plugin "updater_comm"... Oct 16 16:39:31 volumio_streamer volumio[1175]: info: Plugin mpdemulation is not enabled Oct 16 16:39:31 volumio_streamer volumio[1175]: info: Loading plugin "rest_api"... Oct 16 16:39:31 volumio_streamer volumio[1175]: info: Loading plugin "websocket"... Oct 16 16:39:31 volumio_streamer volumio[1175]: info: Loading plugin "spop"... Oct 16 16:39:31 volumio_streamer volumio[1175]: Forking 3 albumart workers Oct 16 16:39:32 volumio_streamer volumio[1175]: Starting albumart workers Oct 16 16:39:32 volumio_streamer volumio[1175]: Starting albumart workers Oct 16 16:39:32 volumio_streamer volumio[1175]: Starting albumart workers Oct 16 16:39:33 volumio_streamer volumio[1175]: info: Loading plugin "volspotconnect2"... Oct 16 16:39:34 volumio_streamer volumio-remote-updater[702]: [2026-10-16 16:39:34] [connect] Successful connection Oct 16 16:39:34 volumio_streamer volumio[1175]: info: ___________ START PLUGINS ___________ Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:39:34 volumio_streamer volumio[1175]: info: [1792168774534] CoreMusicLibrary::Adding element Media Servers Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:39:34 volumio_streamer volumio[1175]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 16:39:34 volumio_streamer volumio[1175]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:39:34 volumio_streamer volumio[1175]: info: [1792168774658] CoreMusicLibrary::Adding element Last_100 Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 16:39:34 volumio_streamer volumio[1175]: info: [1792168774665] CoreMusicLibrary::Adding element Webradio Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 16:39:34 volumio_streamer volumio[1175]: [SpotifyConnect] Creating VLS config file Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer sudo[1332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer sudo[1332]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:34 volumio_streamer volumio[1175]: [SpotifyConnect] Starting metadata listener Oct 16 16:39:34 volumio_streamer sudo[1332]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:34 volumio_streamer volumio[1175]: [SpotifyConnect] Creating VLS config file Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: [SpotifyConnect] Starting metadata listener Oct 16 16:39:34 volumio_streamer sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Oct 16 16:39:34 volumio_streamer sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:34 volumio_streamer volumio[1175]: info: ------------------------------------------- Oct 16 16:39:34 volumio_streamer volumio[1175]: info: ----- MyVolumio plugins startup ---- Oct 16 16:39:34 volumio_streamer volumio[1175]: info: ------------------------------------------- Oct 16 16:39:34 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 16 16:39:34 volumio_streamer sudo[1347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Oct 16 16:39:34 volumio_streamer systemd[1]: Starting Volspotconnect2 Daemon... Oct 16 16:39:34 volumio_streamer systemd[1]: Started Volspotconnect2 Daemon. Oct 16 16:39:34 volumio_streamer volumio[1175]: info: Loading i18n strings for locale en Oct 16 16:39:34 volumio_streamer sudo[1341]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:34 volumio_streamer volumio[1175]: Updating browse sources language Oct 16 16:39:34 volumio_streamer volumio[1175]: Cannot find translation for sourceMedia Servers Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 16:39:34 volumio_streamer sudo[1347]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:34 volumio_streamer systemd[1]: Starting Volspotconnect2 Daemon... Oct 16 16:39:34 volumio_streamer systemd[1]: Started Volspotconnect2 Daemon. Oct 16 16:39:34 volumio_streamer sudo[1347]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::initPlayerControls Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 16:39:34 volumio_streamer volumio[1175]: info: BOOT COMPLETED Oct 16 16:39:34 volumio_streamer volumio[1175]: [Metrics] CommandRouter: 9s 103.39ms Oct 16 16:39:34 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:39:35 volumio_streamer volumio[1349]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 16 16:39:35 volumio_streamer volumio[1349]: Reading Config from "/tmp/volspotify.toml" Oct 16 16:39:35 volumio_streamer volumio[1349]: Malformed config key: missing field `Authentication` Oct 16 16:39:35 volumio_streamer volumio[1357]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Oct 16 16:39:35 volumio_streamer volumio[1357]: Reading Config from "volspotify.toml" Oct 16 16:39:35 volumio_streamer volumio[1357]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 16 16:39:35 volumio_streamer volumio[1357]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Oct 16 16:39:37 volumio_streamer systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 16 16:39:37 volumio_streamer systemd[1]: Stopping Volspotconnect2 Daemon... Oct 16 16:39:37 volumio_streamer systemd[1]: Starting Volspotconnect2 Daemon... Oct 16 16:39:37 volumio_streamer systemd[1]: Started Volspotconnect2 Daemon. Oct 16 16:39:37 volumio_streamer volumio[1367]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 16 16:39:37 volumio_streamer volumio[1367]: Reading Config from "/tmp/volspotify.toml" Oct 16 16:39:37 volumio_streamer volumio[1367]: Malformed config key: missing field `Authentication` Oct 16 16:39:39 volumio_streamer wpa_supplicant[1027]: wlan0: CTRL-EVENT-DISCONNECTED bssid=58:11:22:5d:b7:00 reason=0 locally_generated=1 Oct 16 16:39:39 volumio_streamer dhcpcd[1049]: wlan0: carrier lost Oct 16 16:39:39 volumio_streamer dhcpcd[1049]: eth0: adding route to 192.168.0.0/24 Oct 16 16:39:39 volumio_streamer dhcpcd[1049]: eth0: adding default route via 192.168.0.1 Oct 16 16:39:39 volumio_streamer dhcpcd[1049]: wlan0: deleting host route to 192.168.0.13 via 127.0.0.1 Oct 16 16:39:39 volumio_streamer dhcpcd[1049]: wlan0: deleting route to 192.168.0.0/24 Oct 16 16:39:39 volumio_streamer dhcpcd[1049]: wlan0: deleting default route via 192.168.0.1 Oct 16 16:39:39 volumio_streamer avahi-daemon[775]: Withdrawing address record for 192.168.0.13 on wlan0. Oct 16 16:39:39 volumio_streamer avahi-daemon[775]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.13. Oct 16 16:39:39 volumio_streamer wpa_supplicant[1027]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 16 16:39:39 volumio_streamer avahi-daemon[775]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 16 16:39:39 volumio_streamer dhcpcd[1049]: eth0: removing route to 192.168.0.0/24 Oct 16 16:39:39 volumio_streamer dhcpcd[1049]: eth0: removing default route via 192.168.0.1 Oct 16 16:39:39 volumio_streamer wpa_supplicant[1027]: wlan0: Trying to associate with SSID 'VM1962922' Oct 16 16:39:39 volumio_streamer systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 16 16:39:39 volumio_streamer systemd[1]: Stopping Volspotconnect2 Daemon... Oct 16 16:39:39 volumio_streamer systemd[1]: Starting Volspotconnect2 Daemon... Oct 16 16:39:39 volumio_streamer systemd[1]: Started Volspotconnect2 Daemon. Oct 16 16:39:39 volumio_streamer volumio[1392]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 16 16:39:39 volumio_streamer volumio[1392]: Reading Config from "/tmp/volspotify.toml" Oct 16 16:39:39 volumio_streamer volumio[1392]: Malformed config key: missing field `Authentication` Oct 16 16:39:40 volumio_streamer wpa_supplicant[1027]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Oct 16 16:39:40 volumio_streamer volumio[1175]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 16 16:39:40 volumio_streamer volumio[1175]: info: CoreCommandRouter::Close All Modals sent Oct 16 16:39:40 volumio_streamer volumio[1175]: info: CoreCommandRouter::Close All Modals sent Oct 16 16:39:40 volumio_streamer volumio[1175]: Express server listening on port 3000 Oct 16 16:39:40 volumio_streamer volumio[1175]: [Metrics] WebUI: 15s 249.53ms Oct 16 16:39:40 volumio_streamer volumio[1175]: Volumio Calling Home Oct 16 16:39:40 volumio_streamer volumio[1175]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 Oct 16 16:39:40 volumio_streamer volumio[1175]: at Object._errnoException (util.js:1022:11) Oct 16 16:39:40 volumio_streamer volumio[1175]: at _exceptionWithHostPort (util.js:1044:20) Oct 16 16:39:40 volumio_streamer volumio[1175]: at _handle.lookup (dgram.js:266:18) Oct 16 16:39:40 volumio_streamer volumio[1175]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Oct 16 16:39:40 volumio_streamer volumio[1175]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 16 16:39:40 volumio_streamer volumio[1175]: at Function.Module.runMain (module.js:695:11) Oct 16 16:39:40 volumio_streamer volumio[1175]: at startup (bootstrap_node.js:188:16) Oct 16 16:39:40 volumio_streamer volumio[1175]: at bootstrap_node.js:609:3 Oct 16 16:39:40 volumio_streamer volumio[1175]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data Oct 16 16:39:40 volumio_streamer volumio[1175]: at Socket.onListenError (dgram.js:362:22) Oct 16 16:39:40 volumio_streamer volumio[1175]: at Object.onceWrapper (events.js:315:30) Oct 16 16:39:40 volumio_streamer volumio[1175]: at emitOne (events.js:121:20) Oct 16 16:39:40 volumio_streamer volumio[1175]: at Socket.emit (events.js:211:7) Oct 16 16:39:40 volumio_streamer volumio[1175]: at _handle.lookup (dgram.js:267:14) Oct 16 16:39:40 volumio_streamer volumio[1175]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Oct 16 16:39:40 volumio_streamer volumio[1175]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 16 16:39:40 volumio_streamer volumio[1175]: at Function.Module.runMain (module.js:695:11) Oct 16 16:39:40 volumio_streamer volumio[1175]: at startup (bootstrap_node.js:188:16) Oct 16 16:39:40 volumio_streamer volumio[1175]: at bootstrap_node.js:609:3 Oct 16 16:39:40 volumio_streamer volumio[1175]: info: CoreStateMachine::resetVolumioState Oct 16 16:39:40 volumio_streamer volumio[1175]: info: CoreStateMachine::getcurrentVolume Oct 16 16:39:40 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 16:39:40 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:39:40 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 16:39:40 volumio_streamer sudo[1406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 16:39:40 volumio_streamer sudo[1406]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:40 volumio_streamer sudo[1408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 16:39:40 volumio_streamer sudo[1408]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:40 volumio_streamer sudo[1406]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:40 volumio_streamer sudo[1408]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:40 volumio_streamer ntpd[837]: Deleting interface #4 wlan0, 192.168.0.13#123, interface stats: received=0, sent=0, dropped=0, active_time=17 secs Oct 16 16:39:40 volumio_streamer ntpd[837]: peers refreshed Oct 16 16:39:40 volumio_streamer wpa_supplicant[1027]: wlan0: Trying to associate with SSID 'VM1962922' Oct 16 16:39:40 volumio_streamer volumio[1175]: info: Setting Device type: Raspberry PI Oct 16 16:39:40 volumio_streamer volumio[1175]: [SpotifyConnect] Vollibrespot Daemon service started! Oct 16 16:39:40 volumio_streamer volumio[1175]: [Metrics] SpotifyConnect: 6s 136.62ms Oct 16 16:39:40 volumio_streamer volumio[1175]: [SpotifyConnect] Vollibrespot Daemon service started! Oct 16 16:39:40 volumio_streamer volumio[1175]: [Metrics] SpotifyConnect: 6s 138.53ms Oct 16 16:39:40 volumio_streamer volumio[1175]: info: MPD running with PID777 Oct 16 16:39:40 volumio_streamer volumio[1175]: ,establishing connection Oct 16 16:39:41 volumio_streamer volumio[1175]: info: Oct 16 16:39:41 volumio_streamer volumio[1175]: ---------------------------- Client requests Volume 80 Oct 16 16:39:41 volumio_streamer volumio[1175]: info: VolumeController::SetAlsaVolume80 Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreStateMachine::pushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioPushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:39:41 volumio_streamer wpa_supplicant[1027]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Oct 16 16:39:41 volumio_streamer volumio[1175]: info: VolumeController:: Volume=79 Mute =false Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreStateMachine::pushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioPushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreStateMachine::updateTrackBlock Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CorePlayQueue::getTrackBlock Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 16:39:41 volumio_streamer volumio[1175]: info: Reloading queue from file Oct 16 16:39:41 volumio_streamer volumio[1175]: error: updateQueue error: null Oct 16 16:39:41 volumio_streamer volumio[1175]: error: Failed LSINFO: Error: [50@0] {} No such directory Oct 16 16:39:41 volumio_streamer volumio[1175]: info: Setting volume on startup at 80 Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreStateMachine::setRepeat null single undefined Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreStateMachine::pushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioPushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreStateMachine::setRandom null Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreStateMachine::pushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioPushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:39:41 volumio_streamer volumio[1175]: info: Starting Shairport Sync Oct 16 16:39:41 volumio_streamer volumio[1175]: info: Starting Shairport Sync Oct 16 16:39:41 volumio_streamer sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 16:39:41 volumio_streamer sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:41 volumio_streamer sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 16 16:39:41 volumio_streamer volumio[1175]: info: mDNS: A device disapperared from network Oct 16 16:39:41 volumio_streamer volumio[1175]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Oct 16 16:39:41 volumio_streamer systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 16 16:39:41 volumio_streamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 16 16:39:41 volumio_streamer sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:41 volumio_streamer sudo[1430]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:41 volumio_streamer sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 16 16:39:41 volumio_streamer sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:41 volumio_streamer systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 16 16:39:41 volumio_streamer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 16 16:39:41 volumio_streamer systemd[1]: Stopping Volspotconnect2 Daemon... Oct 16 16:39:41 volumio_streamer systemd[1]: Starting Volspotconnect2 Daemon... Oct 16 16:39:41 volumio_streamer systemd[1]: Started Volspotconnect2 Daemon. Oct 16 16:39:41 volumio_streamer volumio[1452]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 16 16:39:41 volumio_streamer volumio[1452]: Reading Config from "/tmp/volspotify.toml" Oct 16 16:39:41 volumio_streamer systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 16 16:39:41 volumio_streamer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 16 16:39:41 volumio_streamer sudo[1432]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:41 volumio_streamer systemd[1]: Starting UPnP Renderer front-end to MPD... Oct 16 16:39:41 volumio_streamer systemd[1]: Started UPnP Renderer front-end to MPD. Oct 16 16:39:41 volumio_streamer volumio[1452]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 16 16:39:41 volumio_streamer sudo[1439]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:41 volumio_streamer volumio[1175]: info: VolumeController:: Volume=79 Mute =false Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreStateMachine::pushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioPushState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:39:41 volumio_streamer volumio[1175]: Discovery: adding 65365c75-db32-4821-922c-b3310757a6cc Oct 16 16:39:41 volumio_streamer volumio[1175]: info: mDNS: Found device Volumiostreamer Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 16 16:39:41 volumio_streamer volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 16 16:39:41 volumio_streamer volumio[1452]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Oct 16 16:39:42 volumio_streamer volumio[1175]: info: Shairport-Sync Started Oct 16 16:39:42 volumio_streamer volumio[1175]: Error adding Membership: Error: addMembership EINVAL Oct 16 16:39:42 volumio_streamer volumio[1175]: info: Shairport-Sync Started Oct 16 16:39:42 volumio_streamer wpa_supplicant[1027]: wlan0: Trying to associate with SSID 'VM1962922' Oct 16 16:39:42 volumio_streamer wpa_supplicant[1027]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Oct 16 16:39:42 volumio_streamer volumio[1175]: info: Upmpdcli Daemon Started Oct 16 16:39:42 volumio_streamer volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 16 16:39:42 volumio_streamer volumio[1175]: info: CorePlayQueue::getTrack 0 Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 16 16:39:43 volumio_streamer volumio[1175]: info: Adding plugin bluetooth to MyMusic Plugins Oct 16 16:39:43 volumio_streamer volumio[1175]: info: Adding plugin cd_controller to MyMusic Plugins Oct 16 16:39:43 volumio_streamer volumio[1175]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 16 16:39:43 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 16 16:39:44 volumio_streamer wpa_supplicant[1027]: wlan0: Trying to associate with SSID 'VM1962922' Oct 16 16:39:44 volumio_streamer wpa_supplicant[1027]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Oct 16 16:39:44 volumio_streamer wpa_supplicant[1027]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="VM1962922" auth_failures=1 duration=10 reason=CONN_FAILED Oct 16 16:39:45 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 16 16:39:47 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 16 16:39:47 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 16 16:39:47 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:39:47 volumio_streamer volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 16:39:47 volumio_streamer volumio[1175]: info: Starting MyVolumio Remote Streaming Endpoints Oct 16 16:39:47 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 16 16:39:47 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 16 16:39:47 volumio_streamer volumio[1175]: info: Streaming services startup Oct 16 16:39:47 volumio_streamer volumio[1175]: info: Starting Streaming Daemon Oct 16 16:39:47 volumio_streamer sudo[1488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 16:39:47 volumio_streamer sudo[1488]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 16:39:47 volumio_streamer systemd[1]: Stopping Volumio Streaming Daemon... Oct 16 16:39:47 volumio_streamer volumio[1175]: info: MyVolumio not started Oct 16 16:39:47 volumio_streamer volumio[1175]: info: Initializing device activation check Oct 16 16:39:47 volumio_streamer systemd[1]: Starting Volumio Streaming Daemon... Oct 16 16:39:47 volumio_streamer systemd[1]: Started Volumio Streaming Daemon. Oct 16 16:39:47 volumio_streamer sudo[1488]: pam_unix(sudo:session): session closed for user root Oct 16 16:39:47 volumio_streamer volumio-streaming-daemon[1498]: ############################ Oct 16 16:39:47 volumio_streamer volumio-streaming-daemon[1498]: # Volumio Streaming Daemon # Oct 16 16:39:47 volumio_streamer volumio-streaming-daemon[1498]: # Running on port 7777 # Oct 16 16:39:47 volumio_streamer volumio-streaming-daemon[1498]: ############################ Oct 16 16:39:47 volumio_streamer volumio-streaming-daemon[1498]: Environment: production Oct 16 16:39:47 volumio_streamer volumio[1175]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 16 16:39:47 volumio_streamer volumio[1175]: info: Checking Spotify Web API Oct 16 16:39:47 volumio_streamer volumio[1175]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:39:47 volumio_streamer volumio[1175]: { Error: addMembership ENODEV Oct 16 16:39:47 volumio_streamer volumio[1175]: at _errnoException (util.js:1022:11) Oct 16 16:39:47 volumio_streamer volumio[1175]: at Socket.addMembership (dgram.js:615:11) Oct 16 16:39:47 volumio_streamer volumio[1175]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) Oct 16 16:39:47 volumio_streamer volumio[1175]: at ontimeout (timers.js:482:11) Oct 16 16:39:47 volumio_streamer volumio[1175]: at tryOnTimeout (timers.js:317:5) Oct 16 16:39:47 volumio_streamer volumio[1175]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Oct 16 16:39:47 volumio_streamer volumio[1175]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:39:48 volumio_streamer sudo[1515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-16 16:38 Oct 16 16:39:48 volumio_streamer sudo[1515]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Dec 22 14:39:52 CET 2020" VOLUMIO_VERSION="2.861" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="097e28ee6263e31d0bf6b690a02dcab3"