-- Logs begin at Thu 2021-03-04 15:34:08 UTC, end at Sun 2024-10-13 03:01:20 UTC. -- Oct 13 03:00:43 volumio systemd[1]: Time has been changed Oct 13 03:00:43 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:43 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:43 volumio nmbd[922]: [2024/10/13 03:00:43.704356, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 13 03:00:43 volumio nmbd[922]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.50.199 for name WORKGROUP<1d>. Oct 13 03:00:43 volumio nmbd[922]: This response was from IP 192.168.50.151, reporting an IP address of 192.168.50.151. Oct 13 03:00:44 volumio wireless.js[814]: trying... Oct 13 03:00:44 volumio sudo[1041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 13 03:00:44 volumio sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:44 volumio sudo[1041]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:45 volumio wpa_supplicant[995]: wlan0: Trying to associate with SSID 'Wu_24G' Oct 13 03:00:45 volumio wireless.js[814]: trying... Oct 13 03:00:45 volumio sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 13 03:00:45 volumio sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:45 volumio sudo[1050]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:46 volumio wireless.js[814]: trying... Oct 13 03:00:46 volumio sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 13 03:00:46 volumio sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:46 volumio sudo[1059]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:47 volumio wireless.js[814]: trying... Oct 13 03:00:47 volumio sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 13 03:00:47 volumio sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:47 volumio sudo[1068]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:48 volumio wpa_supplicant[995]: wlan0: Associated with d4:5d:64:92:e7:04 Oct 13 03:00:48 volumio wpa_supplicant[995]: wlan0: WPA: Key negotiation completed with d4:5d:64:92:e7:04 [PTK=CCMP GTK=CCMP] Oct 13 03:00:48 volumio wpa_supplicant[995]: wlan0: CTRL-EVENT-CONNECTED - Connection to d4:5d:64:92:e7:04 completed [id=1 id_str=] Oct 13 03:00:48 volumio dhcpcd[1017]: wlan0: carrier acquired Oct 13 03:00:48 volumio wpa_supplicant[995]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Oct 13 03:00:48 volumio dhcpcd[1017]: wlan0: rebinding lease of 192.168.50.104 Oct 13 03:00:48 volumio wireless.js[814]: trying... Oct 13 03:00:48 volumio sudo[1096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 13 03:00:48 volumio sudo[1096]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:48 volumio sudo[1096]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:49 volumio wireless.js[814]: trying... Oct 13 03:00:49 volumio sudo[1105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 13 03:00:49 volumio sudo[1105]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:49 volumio sudo[1105]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:49 volumio kernel: Voltage normalised (0x00000000) Oct 13 03:00:49 volumio volumio-remote-updater[642]: [2024-10-13 03:00:49] [info] asio async_connect error: system:111 (Connection refused) Oct 13 03:00:49 volumio volumio-remote-updater[642]: [2024-10-13 03:00:49] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 13 03:00:49 volumio volumio-remote-updater[642]: [2024-10-13 03:00:49] [error] handle_connect error: Underlying Transport Error Oct 13 03:00:50 volumio wireless.js[814]: trying... Oct 13 03:00:50 volumio sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 13 03:00:50 volumio sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:50 volumio sudo[1114]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:51 volumio dhcpcd[1017]: wlan0: leased 192.168.50.104 for 86400 seconds Oct 13 03:00:51 volumio avahi-daemon[721]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.50.104. Oct 13 03:00:51 volumio avahi-daemon[721]: New relevant interface wlan0.IPv4 for mDNS. Oct 13 03:00:51 volumio dhcpcd[1017]: eth0: adding route to 192.168.50.0/24 Oct 13 03:00:51 volumio avahi-daemon[721]: Registering new address record for 192.168.50.104 on wlan0.IPv4. Oct 13 03:00:51 volumio dhcpcd[1017]: eth0: adding default route via 192.168.50.1 Oct 13 03:00:51 volumio dhcpcd[1017]: wlan0: adding host route to 192.168.50.104 via 127.0.0.1 Oct 13 03:00:51 volumio dhcpcd[1017]: wlan0: adding route to 192.168.50.0/24 Oct 13 03:00:51 volumio dhcpcd[1017]: wlan0: adding default route via 192.168.50.1 Oct 13 03:00:51 volumio dhcpcd[1017]: eth0: removing route to 192.168.50.0/24 Oct 13 03:00:51 volumio dhcpcd[1017]: eth0: removing default route via 192.168.50.1 Oct 13 03:00:51 volumio wireless.js[814]: trying... Oct 13 03:00:51 volumio sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 13 03:00:51 volumio sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:51 volumio sudo[1145]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:51 volumio wireless.js[814]: Connected to: ----Wu_24G Oct 13 03:00:51 volumio wireless.js[814]: ---- Oct 13 03:00:51 volumio sudo[1154]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 03:00:51 volumio sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:51 volumio sudo[1154]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:51 volumio wireless.js[814]: ... joined AP, wlan0 IPv4 is 192.168.50.104, ipV6 is undefined Oct 13 03:00:51 volumio wireless.js[814]: It's done! AP Oct 13 03:00:51 volumio systemd[1]: Started Wireless Services. Oct 13 03:00:51 volumio systemd[1]: Starting Volumio Backend Module... Oct 13 03:00:51 volumio systemd[1]: Started Volumio Backend Module. Oct 13 03:00:51 volumio systemd[1]: Starting Volumio Streaming Daemon... Oct 13 03:00:51 volumio systemd[1]: Started Volumio Streaming Daemon. Oct 13 03:00:51 volumio systemd[1]: Starting Multi-User System. Oct 13 03:00:51 volumio systemd[1]: Reached target Multi-User System. Oct 13 03:00:51 volumio systemd[1]: Starting Graphical Interface. Oct 13 03:00:51 volumio systemd[1]: Reached target Graphical Interface. Oct 13 03:00:51 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 13 03:00:51 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 13 03:00:51 volumio systemd[1]: Startup finished in 10.152s (kernel) + 22.622s (userspace) = 32.774s. Oct 13 03:00:51 volumio volumio-streaming-daemon[1164]: ############################ Oct 13 03:00:51 volumio volumio-streaming-daemon[1164]: # Volumio Streaming Daemon # Oct 13 03:00:51 volumio volumio-streaming-daemon[1164]: # Running on port 7777 # Oct 13 03:00:51 volumio volumio-streaming-daemon[1164]: ############################ Oct 13 03:00:51 volumio volumio-streaming-daemon[1164]: Environment: production Oct 13 03:00:53 volumio ntpd[796]: Listen normally on 4 wlan0 192.168.50.104 UDP 123 Oct 13 03:00:53 volumio ntpd[796]: peers refreshed Oct 13 03:00:54 volumio volumio[1163]: info: ------------------------------------------- Oct 13 03:00:54 volumio volumio[1163]: info: ----- Volumio2 ---- Oct 13 03:00:54 volumio volumio[1163]: info: ------------------------------------------- Oct 13 03:00:54 volumio volumio[1163]: info: ----- System startup ---- Oct 13 03:00:54 volumio volumio[1163]: info: ------------------------------------------- Oct 13 03:00:54 volumio volumio[1163]: info: MYVOLUMIO Environment detected Oct 13 03:00:55 volumio volumio[1163]: info: Plugin folders cleanup Oct 13 03:00:55 volumio volumio[1163]: info: Scanning into folder /volumio/app/plugins/ Oct 13 03:00:55 volumio volumio[1163]: info: Scanning category audio_interface Oct 13 03:00:55 volumio volumio[1163]: info: Scanning category miscellanea Oct 13 03:00:55 volumio volumio[1163]: info: Scanning category music_service Oct 13 03:00:55 volumio volumio[1163]: info: Scanning category plugins.json Oct 13 03:00:55 volumio volumio[1163]: info: Scanning category system_controller Oct 13 03:00:55 volumio volumio[1163]: info: Scanning category user_interface Oct 13 03:00:55 volumio volumio[1163]: info: Scanning into folder /data/plugins/ Oct 13 03:00:55 volumio volumio[1163]: info: Scanning category music_service Oct 13 03:00:55 volumio volumio[1163]: info: Plugin folders cleanup completed Oct 13 03:00:55 volumio volumio[1163]: info: ------------------------------------------- Oct 13 03:00:55 volumio volumio[1163]: info: ----- Core plugins startup ---- Oct 13 03:00:55 volumio volumio[1163]: info: ------------------------------------------- Oct 13 03:00:55 volumio volumio[1163]: info: Loading plugins from folder /volumio/app/plugins/ Oct 13 03:00:55 volumio volumio[1163]: info: Adding plugin upnp to MyMusic Plugins Oct 13 03:00:55 volumio volumio[1163]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 13 03:00:55 volumio volumio[1163]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 13 03:00:55 volumio volumio[1163]: info: Loading plugins from folder /data/plugins/ Oct 13 03:00:55 volumio volumio[1163]: info: Loading plugin "system"... Oct 13 03:00:55 volumio volumio[1163]: info: Loading plugin "appearance"... Oct 13 03:00:56 volumio volumio[1163]: info: Loading plugin "network"... Oct 13 03:00:56 volumio volumio[1163]: info: Refreshing Cached IP Addresses Oct 13 03:00:56 volumio sudo[1189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 03:00:56 volumio volumio[1163]: info: Loading plugin "services"... Oct 13 03:00:56 volumio sudo[1189]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:56 volumio volumio[1163]: info: Loading plugin "alsa_controller"... Oct 13 03:00:56 volumio sudo[1189]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:56 volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 03:00:56 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:00:56 volumio sudo[1191]: pam_unix(sudo:session): session closed for user root Oct 13 03:00:57 volumio volumio[1163]: info: Loading plugin "wizard"... Oct 13 03:00:57 volumio volumio[1163]: info: Loading plugin "volumio_command_line_client"... Oct 13 03:00:57 volumio volumio[1163]: info: Loading plugin "upnp"... Oct 13 03:00:57 volumio volumio[1163]: info: [1728788457116] Starting Upmpd Daemon Oct 13 03:00:57 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 03:00:57 volumio volumio[1163]: info: Loading plugin "my_music"... Oct 13 03:00:57 volumio volumio[1163]: info: Loading plugin "mpd"... Oct 13 03:00:57 volumio volumio[1163]: info: Loading plugin "upnp_browser"... Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "networkfs"... Oct 13 03:00:58 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "alarm-clock"... Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "airplay_emulation"... Oct 13 03:00:58 volumio volumio[1163]: info: Starting Shairport Sync Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "last_100"... Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "webradio"... Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "i2s_dacs"... Oct 13 03:00:58 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "volumiodiscovery"... Oct 13 03:00:58 volumio volumio[1163]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 03:00:58 volumio node[1163]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 03:00:58 volumio node[1163]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 03:00:58 volumio node[1163]: *** WARNING *** For more information see Oct 13 03:00:58 volumio node[1163]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 03:00:58 volumio node[1163]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 03:00:58 volumio node[1163]: *** WARNING *** For more information see Oct 13 03:00:58 volumio volumio[1163]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 03:00:58 volumio volumio[1163]: *** WARNING *** For more information see Oct 13 03:00:58 volumio volumio[1163]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 03:00:58 volumio volumio[1163]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 03:00:58 volumio volumio[1163]: *** WARNING *** For more information see Oct 13 03:00:58 volumio volumio[1163]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 13 03:00:58 volumio volumio[1163]: Discovery: StartAdv! undefined Oct 13 03:00:58 volumio volumio[1163]: Discovery: Started advertising... Volumio - undefined Oct 13 03:00:58 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "outputs"... Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "albumart"... Oct 13 03:00:58 volumio volumio[1163]: info: Plugin example_plugin is not enabled Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "inputs"... Oct 13 03:00:58 volumio volumio[1163]: info: Loading plugin "updater_comm"... Oct 13 03:00:59 volumio volumio[1163]: info: Plugin mpdemulation is not enabled Oct 13 03:00:59 volumio volumio[1163]: info: Loading plugin "rest_api"... Oct 13 03:00:59 volumio volumio[1163]: info: Loading plugin "websocket"... Oct 13 03:00:59 volumio volumio[1163]: info: Loading plugin "80s80s"... Oct 13 03:00:59 volumio volumio[1163]: Forking 3 albumart workers Oct 13 03:00:59 volumio volumio-remote-updater[642]: [2024-10-13 03:00:59] [connect] Successful connection Oct 13 03:00:59 volumio kernel: Under-voltage detected! (0x00050005) Oct 13 03:01:00 volumio volumio[1163]: info: Applying required configuration parameters for plugin 80s80s Oct 13 03:01:00 volumio volumio[1163]: info: [1728788460045] [80s80s] API delay: 30 Oct 13 03:01:00 volumio volumio[1163]: info: Loading plugin "RoonBridge"... Oct 13 03:01:00 volumio volumio[1163]: Starting albumart workers Oct 13 03:01:00 volumio volumio[1163]: Starting albumart workers Oct 13 03:01:00 volumio volumio[1163]: Starting albumart workers Oct 13 03:01:00 volumio volumio[1163]: info: Applying required configuration parameters for plugin RoonBridge Oct 13 03:01:00 volumio volumio[1163]: info: Loading plugin "onedrive_music_library"... Oct 13 03:01:03 volumio volumio[1163]: info: Loading plugin "spop"... Oct 13 03:01:04 volumio volumio[1163]: info: Loading plugin "volspotconnect2"... Oct 13 03:01:05 volumio volumio[1163]: info: ___________ START PLUGINS ___________ Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 03:01:05 volumio volumio[1163]: info: [1728788465311] CoreMusicLibrary::Adding element Media Servers Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 03:01:05 volumio volumio[1163]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 13 03:01:05 volumio volumio[1163]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 03:01:05 volumio volumio[1163]: info: [1728788465417] CoreMusicLibrary::Adding element Last_100 Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 03:01:05 volumio volumio[1163]: info: [1728788465420] CoreMusicLibrary::Adding element Webradio Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 03:01:05 volumio volumio[1163]: info: [1728788465445] CoreMusicLibrary::Adding element 80s80s Radio Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 03:01:05 volumio volumio[1163]: info: [1728788465461] CoreMusicLibrary::Adding element Onedrive Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 03:01:05 volumio sudo[1271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Oct 13 03:01:05 volumio sudo[1271]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:05 volumio wpa_supplicant[995]: wlan0: WNM: Preferred List Available Oct 13 03:01:05 volumio systemd[1]: Starting RoonBridge... Oct 13 03:01:05 volumio systemd[1]: Started RoonBridge. Oct 13 03:01:05 volumio sudo[1271]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 03:01:05 volumio volumio[1163]: [SpotifyConnect] Creating VLS config file Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: [SpotifyConnect] Starting metadata listener Oct 13 03:01:05 volumio sudo[1283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Oct 13 03:01:05 volumio sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:05 volumio sudo[1283]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:05 volumio volumio[1163]: [SpotifyConnect] Creating VLS config file Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: [SpotifyConnect] Starting metadata listener Oct 13 03:01:05 volumio sudo[1294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Oct 13 03:01:05 volumio sudo[1294]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:05 volumio volumio[1163]: info: ------------------------------------------- Oct 13 03:01:05 volumio volumio[1163]: info: ----- MyVolumio plugins startup ---- Oct 13 03:01:05 volumio volumio[1163]: info: ------------------------------------------- Oct 13 03:01:05 volumio volumio[1163]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 13 03:01:05 volumio sudo[1301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Oct 13 03:01:05 volumio systemd[1]: Starting Volspotconnect2 Daemon... Oct 13 03:01:05 volumio systemd[1]: Started Volspotconnect2 Daemon. Oct 13 03:01:05 volumio sudo[1301]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:05 volumio sudo[1294]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:05 volumio volumio[1163]: info: Loading i18n strings for locale zh_TW Oct 13 03:01:05 volumio systemd[1]: Starting Volspotconnect2 Daemon... Oct 13 03:01:05 volumio systemd[1]: Started Volspotconnect2 Daemon. Oct 13 03:01:05 volumio sudo[1301]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:05 volumio volumio[1163]: Updating browse sources language Oct 13 03:01:05 volumio volumio[1163]: Cannot find translation for sourceMedia Servers Oct 13 03:01:05 volumio volumio[1163]: Cannot find translation for source80s80s Radio Oct 13 03:01:05 volumio volumio[1163]: Cannot find translation for sourceOnedrive Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::initPlayerControls Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:05 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 13 03:01:06 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:06 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:06 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:06 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:06 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:06 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 03:01:06 volumio volumio[1306]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 13 03:01:06 volumio volumio[1306]: Reading Config from "/tmp/volspotify.toml" Oct 13 03:01:06 volumio volumio[1163]: info: BOOT COMPLETED Oct 13 03:01:06 volumio volumio[1306]: Malformed config key: missing field `Authentication` Oct 13 03:01:06 volumio volumio[1163]: [Metrics] CommandRouter: 11s 799.31ms Oct 13 03:01:06 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 03:01:06 volumio volumio[1313]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Oct 13 03:01:06 volumio volumio[1313]: Reading Config from "volspotify.toml" Oct 13 03:01:06 volumio volumio[1313]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 13 03:01:06 volumio volumio[1313]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Oct 13 03:01:06 volumio wpa_supplicant[995]: wlan0: WNM: Preferred List Available Oct 13 03:01:07 volumio dhcpcd[1017]: wlan0: carrier lost Oct 13 03:01:07 volumio wpa_supplicant[995]: wlan0: CTRL-EVENT-DISCONNECTED bssid=d4:5d:64:92:e7:04 reason=2 locally_generated=1 Oct 13 03:01:07 volumio dhcpcd[1017]: eth0: adding route to 192.168.50.0/24 Oct 13 03:01:07 volumio dhcpcd[1017]: eth0: adding default route via 192.168.50.1 Oct 13 03:01:07 volumio dhcpcd[1017]: wlan0: deleting host route to 192.168.50.104 via 127.0.0.1 Oct 13 03:01:07 volumio dhcpcd[1017]: wlan0: deleting route to 192.168.50.0/24 Oct 13 03:01:07 volumio dhcpcd[1017]: wlan0: deleting default route via 192.168.50.1 Oct 13 03:01:07 volumio avahi-daemon[721]: Withdrawing address record for 192.168.50.104 on wlan0. Oct 13 03:01:07 volumio avahi-daemon[721]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.50.104. Oct 13 03:01:07 volumio avahi-daemon[721]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 13 03:01:07 volumio wpa_supplicant[995]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Oct 13 03:01:07 volumio wpa_supplicant[995]: wlan0: Reject scan trigger since one is already pending Oct 13 03:01:07 volumio wpa_supplicant[995]: wlan0: Failed to initiate AP scan Oct 13 03:01:07 volumio dhcpcd[1017]: eth0: removing route to 192.168.50.0/24 Oct 13 03:01:07 volumio dhcpcd[1017]: eth0: removing default route via 192.168.50.1 Oct 13 03:01:08 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 13 03:01:08 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Oct 13 03:01:08 volumio systemd[1]: Starting Volspotconnect2 Daemon... Oct 13 03:01:08 volumio systemd[1]: Started Volspotconnect2 Daemon. Oct 13 03:01:08 volumio volumio[1350]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 13 03:01:08 volumio volumio[1350]: Reading Config from "/tmp/volspotify.toml" Oct 13 03:01:08 volumio volumio[1350]: Malformed config key: missing field `Authentication` Oct 13 03:01:08 volumio RoonBridge[1276]: 00:00:00.029 Warn: get lock file path: /tmp/.rnbgem0- Oct 13 03:01:08 volumio wpa_supplicant[995]: wlan0: Reject scan trigger since one is already pending Oct 13 03:01:08 volumio wpa_supplicant[995]: wlan0: Failed to initiate AP scan Oct 13 03:01:09 volumio ntpd[796]: Deleting interface #4 wlan0, 192.168.50.104#123, interface stats: received=0, sent=0, dropped=0, active_time=16 secs Oct 13 03:01:09 volumio ntpd[796]: peers refreshed Oct 13 03:01:09 volumio RoonBridge[1276]: 00:00:00.921 Trace: [childprocess] using unix child process Oct 13 03:01:09 volumio RoonBridge[1276]: 00:00:01.000 Debug: PathForResource, filename: ../.update Oct 13 03:01:09 volumio RoonBridge[1276]: 00:00:01.109 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Oct 13 03:01:09 volumio RoonBridge[1276]: 00:00:01.118 Debug: PathForResource, filename: RAATServer Oct 13 03:01:09 volumio RoonBridge[1276]: 00:00:01.118 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Oct 13 03:01:09 volumio RoonBridge[1276]: 00:00:01.119 Debug: PathForResource, filename: RoonBridgeHelper Oct 13 03:01:09 volumio RoonBridge[1276]: 00:00:01.120 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Oct 13 03:01:09 volumio RoonBridge[1276]: Initializing Oct 13 03:01:09 volumio RoonBridge[1276]: 00:00:01.171 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Oct 13 03:01:09 volumio RoonBridge[1276]: 00:00:01.219 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Oct 13 03:01:09 volumio RoonBridge[1276]: Not Running (.o) Oct 13 03:01:09 volumio RoonBridge[1276]: Running Oct 13 03:01:10 volumio RoonBridge[1276]: 00:00:00.039 Warn: get lock file path: /tmp/.rnbhgem0- Oct 13 03:01:10 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 13 03:01:10 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Oct 13 03:01:10 volumio systemd[1]: Starting Volspotconnect2 Daemon... Oct 13 03:01:10 volumio systemd[1]: Started Volspotconnect2 Daemon. Oct 13 03:01:10 volumio volumio[1377]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 13 03:01:10 volumio volumio[1377]: Reading Config from "/tmp/volspotify.toml" Oct 13 03:01:10 volumio volumio[1377]: Malformed config key: missing field `Authentication` Oct 13 03:01:11 volumio volumio[1163]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 13 03:01:11 volumio volumio[1163]: info: CoreCommandRouter::Close All Modals sent Oct 13 03:01:11 volumio volumio[1163]: info: CoreCommandRouter::Close All Modals sent Oct 13 03:01:11 volumio volumio[1163]: Express server listening on port 3000 Oct 13 03:01:11 volumio volumio[1163]: [Metrics] WebUI: 18s 148.59ms Oct 13 03:01:11 volumio volumio[1163]: Volumio Calling Home Oct 13 03:01:11 volumio volumio[1163]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 Oct 13 03:01:11 volumio volumio[1163]: at Object._errnoException (util.js:1022:11) Oct 13 03:01:11 volumio volumio[1163]: at _exceptionWithHostPort (util.js:1044:20) Oct 13 03:01:11 volumio volumio[1163]: at _handle.lookup (dgram.js:266:18) Oct 13 03:01:11 volumio volumio[1163]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Oct 13 03:01:11 volumio volumio[1163]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 13 03:01:11 volumio volumio[1163]: at Function.Module.runMain (module.js:695:11) Oct 13 03:01:11 volumio volumio[1163]: at startup (bootstrap_node.js:188:16) Oct 13 03:01:11 volumio volumio[1163]: at bootstrap_node.js:609:3 Oct 13 03:01:11 volumio volumio[1163]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data Oct 13 03:01:11 volumio volumio[1163]: at Socket.onListenError (dgram.js:362:22) Oct 13 03:01:11 volumio volumio[1163]: at Object.onceWrapper (events.js:315:30) Oct 13 03:01:11 volumio volumio[1163]: at emitOne (events.js:121:20) Oct 13 03:01:11 volumio volumio[1163]: at Socket.emit (events.js:211:7) Oct 13 03:01:11 volumio volumio[1163]: at _handle.lookup (dgram.js:267:14) Oct 13 03:01:11 volumio volumio[1163]: at _combinedTickCallback (internal/process/next_tick.js:141:11) Oct 13 03:01:11 volumio volumio[1163]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 13 03:01:11 volumio volumio[1163]: at Function.Module.runMain (module.js:695:11) Oct 13 03:01:11 volumio volumio[1163]: at startup (bootstrap_node.js:188:16) Oct 13 03:01:11 volumio volumio[1163]: at bootstrap_node.js:609:3 Oct 13 03:01:11 volumio volumio[1163]: info: CoreStateMachine::resetVolumioState Oct 13 03:01:11 volumio volumio[1163]: info: CoreStateMachine::getcurrentVolume Oct 13 03:01:11 volumio volumio[1163]: info: CoreCommandRouter::volumioRetrievevolume Oct 13 03:01:12 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 03:01:12 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 03:01:12 volumio sudo[1392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 03:01:12 volumio sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 03:01:12 volumio sudo[1392]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:12 volumio sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:12 volumio sudo[1392]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:12 volumio sudo[1393]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:12 volumio wpa_supplicant[995]: wlan0: Trying to associate with SSID 'Wu_24G' Oct 13 03:01:12 volumio volumio[1163]: info: Setting Device type: Raspberry PI Oct 13 03:01:12 volumio volumio[1163]: [SpotifyConnect] Vollibrespot Daemon service started! Oct 13 03:01:12 volumio volumio[1163]: [Metrics] SpotifyConnect: 7s 297.43ms Oct 13 03:01:12 volumio volumio[1163]: [SpotifyConnect] Vollibrespot Daemon service started! Oct 13 03:01:12 volumio volumio[1163]: [Metrics] SpotifyConnect: 7s 301.47ms Oct 13 03:01:12 volumio volumio[1163]: info: MPD running with PID735 Oct 13 03:01:12 volumio volumio[1163]: ,establishing connection Oct 13 03:01:12 volumio systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Oct 13 03:01:12 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Oct 13 03:01:12 volumio systemd[1]: Starting Volspotconnect2 Daemon... Oct 13 03:01:12 volumio systemd[1]: Started Volspotconnect2 Daemon. Oct 13 03:01:12 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 13 03:01:12 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 03:01:12 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 13 03:01:12 volumio volumio[1411]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Oct 13 03:01:12 volumio volumio[1411]: Reading Config from "/tmp/volspotify.toml" Oct 13 03:01:12 volumio volumio[1411]: [Vollibrespot] : Using Alsa backend with device: plughw:2 Oct 13 03:01:13 volumio volumio[1411]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Uncategorized, message: "No such device" } Oct 13 03:01:13 volumio volumio[1163]: info: VolumeController:: Volume=100 Mute =false Oct 13 03:01:13 volumio volumio[1163]: info: CoreStateMachine::pushState Oct 13 03:01:13 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Oct 13 03:01:13 volumio volumio[1163]: info: CoreCommandRouter::volumioPushState Oct 13 03:01:13 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 03:01:13 volumio volumio[1163]: info: CoreStateMachine::updateTrackBlock Oct 13 03:01:13 volumio volumio[1163]: info: CorePlayQueue::getTrackBlock Oct 13 03:01:13 volumio volumio[1163]: info: CoreCommandRouter::volumioRetrievevolume Oct 13 03:01:13 volumio volumio[1163]: info: Reloading queue from file Oct 13 03:01:14 volumio volumio[1163]: error: updateQueue error: null Oct 13 03:01:14 volumio volumio[1163]: error: Failed LSINFO: Error: [50@0] {} No such directory Oct 13 03:01:14 volumio volumio[1163]: info: CoreStateMachine::setRepeat false single undefined Oct 13 03:01:14 volumio volumio[1163]: info: CoreStateMachine::pushState Oct 13 03:01:14 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Oct 13 03:01:14 volumio volumio[1163]: info: CoreCommandRouter::volumioPushState Oct 13 03:01:14 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 03:01:14 volumio volumio[1163]: info: CoreStateMachine::setRandom undefined Oct 13 03:01:14 volumio volumio[1163]: info: CoreStateMachine::pushState Oct 13 03:01:14 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Oct 13 03:01:14 volumio volumio[1163]: info: CoreCommandRouter::volumioPushState Oct 13 03:01:14 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 03:01:14 volumio volumio[1163]: info: Starting Shairport Sync Oct 13 03:01:14 volumio volumio[1163]: info: Starting Shairport Sync Oct 13 03:01:14 volumio sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 13 03:01:14 volumio sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 13 03:01:14 volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:14 volumio sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:14 volumio sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 13 03:01:14 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Oct 13 03:01:14 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 13 03:01:14 volumio volumio-remote-updater[642]: [2024-10-13 03:01:14] [connect] Successful connection Oct 13 03:01:14 volumio sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:14 volumio sudo[1421]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:14 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 13 03:01:14 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 13 03:01:14 volumio sudo[1423]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:14 volumio volumio[1163]: info: VolumeController:: Volume=100 Mute =false Oct 13 03:01:14 volumio volumio[1163]: info: CoreStateMachine::pushState Oct 13 03:01:14 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Oct 13 03:01:14 volumio volumio[1163]: info: CoreCommandRouter::volumioPushState Oct 13 03:01:14 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 03:01:14 volumio volumio[1163]: info: mDNS: A device disapperared from network Oct 13 03:01:14 volumio volumio[1163]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Oct 13 03:01:15 volumio volumio[1163]: info: Upmpdcli Daemon Started Oct 13 03:01:15 volumio sudo[1430]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:15 volumio volumio-remote-updater[642]: [2024-10-13 03:01:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1728788474 101 Oct 13 03:01:15 volumio volumio[1163]: info: Shairport-Sync Started Oct 13 03:01:15 volumio volumio[1163]: Error adding Membership: Error: addMembership EINVAL Oct 13 03:01:15 volumio volumio[1163]: info: CoreCommandRouter::volumioGetState Oct 13 03:01:15 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Oct 13 03:01:15 volumio volumio[1163]: info: Shairport-Sync Started Oct 13 03:01:15 volumio volumio[1163]: Discovery: adding f706200b-fc0b-48d6-a204-4273075cbea2 Oct 13 03:01:15 volumio volumio[1163]: info: mDNS: Found device Volumio Oct 13 03:01:15 volumio volumio[1163]: info: CoreCommandRouter::volumioGetState Oct 13 03:01:15 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Oct 13 03:01:15 volumio wpa_supplicant[995]: wlan0: Associated with d4:5d:64:92:e7:01 Oct 13 03:01:15 volumio wpa_supplicant[995]: wlan0: WPA: Key negotiation completed with d4:5d:64:92:e7:01 [PTK=CCMP GTK=CCMP] Oct 13 03:01:15 volumio wpa_supplicant[995]: wlan0: CTRL-EVENT-CONNECTED - Connection to d4:5d:64:92:e7:01 completed [id=1 id_str=] Oct 13 03:01:15 volumio dhcpcd[1017]: wlan0: carrier acquired Oct 13 03:01:15 volumio wpa_supplicant[995]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 13 03:01:15 volumio volumio[1163]: info: Adding plugin bluetooth to MyMusic Plugins Oct 13 03:01:15 volumio volumio[1163]: info: Adding plugin cd_controller to MyMusic Plugins Oct 13 03:01:15 volumio dhcpcd[1017]: wlan0: rebinding lease of 192.168.50.104 Oct 13 03:01:15 volumio volumio[1163]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 13 03:01:15 volumio volumio[1163]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 13 03:01:18 volumio volumio[1163]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 13 03:01:18 volumio kernel: Voltage normalised (0x00000000) Oct 13 03:01:20 volumio volumio[1163]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 13 03:01:20 volumio volumio[1163]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 13 03:01:20 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 03:01:20 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 03:01:20 volumio volumio[1163]: info: Starting MyVolumio Remote Streaming Endpoints Oct 13 03:01:20 volumio volumio[1163]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 13 03:01:20 volumio volumio[1163]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 13 03:01:20 volumio volumio[1163]: info: Streaming services startup Oct 13 03:01:20 volumio volumio[1163]: info: Starting Streaming Daemon Oct 13 03:01:20 volumio volumio[1163]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 13 03:01:20 volumio sudo[1516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 13 03:01:20 volumio sudo[1516]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:20 volumio systemd[1]: Stopping Volumio Streaming Daemon... Oct 13 03:01:20 volumio systemd[1]: Starting Volumio Streaming Daemon... Oct 13 03:01:20 volumio systemd[1]: Started Volumio Streaming Daemon. Oct 13 03:01:20 volumio sudo[1516]: pam_unix(sudo:session): session closed for user root Oct 13 03:01:20 volumio volumio-streaming-daemon[1522]: ############################ Oct 13 03:01:20 volumio volumio-streaming-daemon[1522]: # Volumio Streaming Daemon # Oct 13 03:01:20 volumio volumio-streaming-daemon[1522]: # Running on port 7777 # Oct 13 03:01:20 volumio volumio-streaming-daemon[1522]: ############################ Oct 13 03:01:20 volumio volumio-streaming-daemon[1522]: Environment: production Oct 13 03:01:20 volumio volumio[1163]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 03:01:20 volumio volumio[1163]: { Error: addMembership ENODEV Oct 13 03:01:20 volumio volumio[1163]: at _errnoException (util.js:1022:11) Oct 13 03:01:20 volumio volumio[1163]: at Socket.addMembership (dgram.js:615:11) Oct 13 03:01:20 volumio volumio[1163]: at Timeout.addMembership [as _onTimeout] (/volumio/node_modules/node-ssdp/lib/index.js:264:16) Oct 13 03:01:20 volumio volumio[1163]: at ontimeout (timers.js:482:11) Oct 13 03:01:20 volumio volumio[1163]: at tryOnTimeout (timers.js:317:5) Oct 13 03:01:20 volumio volumio[1163]: at Timer.listOnTimeout (timers.js:277:5) code: 'ENODEV', errno: 'ENODEV', syscall: 'addMembership' } Oct 13 03:01:20 volumio volumio[1163]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 03:01:20 volumio dhcpcd[1017]: wlan0: soliciting a DHCP lease Oct 13 03:01:20 volumio dhcpcd[1017]: wlan0: offered 192.168.50.104 from 192.168.50.1 Oct 13 03:01:20 volumio dhcpcd[1017]: wlan0: leased 192.168.50.104 for 86400 seconds Oct 13 03:01:20 volumio avahi-daemon[721]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.50.104. Oct 13 03:01:20 volumio avahi-daemon[721]: New relevant interface wlan0.IPv4 for mDNS. Oct 13 03:01:20 volumio dhcpcd[1017]: eth0: adding route to 192.168.50.0/24 Oct 13 03:01:20 volumio dhcpcd[1017]: eth0: adding default route via 192.168.50.1 Oct 13 03:01:20 volumio avahi-daemon[721]: Registering new address record for 192.168.50.104 on wlan0.IPv4. Oct 13 03:01:20 volumio dhcpcd[1017]: wlan0: adding host route to 192.168.50.104 via 127.0.0.1 Oct 13 03:01:20 volumio dhcpcd[1017]: wlan0: adding route to 192.168.50.0/24 Oct 13 03:01:20 volumio dhcpcd[1017]: wlan0: adding default route via 192.168.50.1 Oct 13 03:01:20 volumio sudo[1539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-13 03:00 Oct 13 03:01:20 volumio sudo[1539]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 03:01:20 volumio dhcpcd[1017]: eth0: removing route to 192.168.50.0/24 Oct 13 03:01:20 volumio dhcpcd[1017]: eth0: removing default route via 192.168.50.1 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="ceaca221623bd3cfdc448100963369088321c5bb" VOLUMIO_FE_VERSION="4917998f86709e30d6499627aa39df0350cb55f8" VOLUMIO_BE_VERSION="2eb1d573179cee7a262e71ad6e6f6c07489b563f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 29 20:47:51 CEST 2020" VOLUMIO_VERSION="2.806" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="a5dbec2d8b23cb06ebf9780d5fc2c84f"