-- Logs begin at Thu 2019-02-14 19:11:58 KST, end at Thu 2025-10-30 08:32:32 KST. -- Oct 30 08:31:07 top-core-1 systemd-timedated[1221]: Changed local time to Thu Oct 30 08:31:07 2025 Oct 30 08:31:07 top-core-1 sudo[1219]: pam_unix(sudo:session): session closed for user root Oct 30 08:31:07 top-core-1 volumio[800]: info: Discovery: A device disappeared from network Oct 30 08:31:07 top-core-1 volumio[800]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Oct 30 08:31:07 top-core-1 volumio-time-update[559]: volumio-time-update-util: System time updated successfully. Oct 30 08:31:07 top-core-1 systemd[1]: Starting Daily apt download activities... Oct 30 08:31:07 top-core-1 systemd[1]: Started Volumio Time Update Utility. Oct 30 08:31:07 top-core-1 systemd[1]: Reached target Multi-User System. Oct 30 08:31:07 top-core-1 systemd[1]: Reached target Graphical Interface. Oct 30 08:31:07 top-core-1 systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 30 08:31:07 top-core-1 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 30 08:31:07 top-core-1 systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 30 08:31:07 top-core-1 volumio[800]: info: Discovery: adding 9c851e8b-5c4f-4f49-a258-2391803e1255 Oct 30 08:31:07 top-core-1 volumio[800]: info: Discovery: Found device Top Core 1 Oct 30 08:31:07 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:31:07 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:31:07 top-core-1 systemd[1]: apt-daily.service: Succeeded. Oct 30 08:31:07 top-core-1 systemd[1]: Started Daily apt download activities. Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Oct 30 08:31:07 top-core-1 volumio[800]: info: Adding plugin bluetooth to MyMusic Plugins Oct 30 08:31:07 top-core-1 volumio[800]: info: Adding plugin multiroom to MyMusic Plugins Oct 30 08:31:07 top-core-1 volumio[800]: info: Adding plugin metavolumio to MyMusic Plugins Oct 30 08:31:07 top-core-1 volumio[800]: info: Adding plugin cd_controller to MyMusic Plugins Oct 30 08:31:07 top-core-1 systemd[1]: Starting Daily apt upgrade and clean activities... Oct 30 08:31:07 top-core-1 volumio[800]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 30 08:31:07 top-core-1 volumio[800]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 30 08:31:07 top-core-1 volumio[800]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 30 08:31:07 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.151973, 0] ../source3/libsmb/nmblib.c:917(send_udp) Oct 30 08:31:08 top-core-1 nmbd[743]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152354, 0] ../source3/libsmb/nmblib.c:917(send_udp) Oct 30 08:31:08 top-core-1 nmbd[743]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152437, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Oct 30 08:31:08 top-core-1 nmbd[743]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152506, 0] ../source3/libsmb/nmblib.c:917(send_udp) Oct 30 08:31:08 top-core-1 nmbd[743]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152571, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Oct 30 08:31:08 top-core-1 nmbd[743]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152639, 0] ../source3/libsmb/nmblib.c:917(send_udp) Oct 30 08:31:08 top-core-1 nmbd[743]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152704, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Oct 30 08:31:08 top-core-1 nmbd[743]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152773, 0] ../source3/libsmb/nmblib.c:917(send_udp) Oct 30 08:31:08 top-core-1 nmbd[743]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152838, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Oct 30 08:31:08 top-core-1 nmbd[743]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152933, 0] ../source3/libsmb/nmblib.c:917(send_udp) Oct 30 08:31:08 top-core-1 nmbd[743]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Oct 30 08:31:08 top-core-1 nmbd[743]: [2025/10/30 08:31:08.152997, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Oct 30 08:31:08 top-core-1 nmbd[743]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Oct 30 08:31:08 top-core-1 systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 30 08:31:08 top-core-1 systemd[1]: Started Daily apt upgrade and clean activities. Oct 30 08:31:08 top-core-1 systemd[1]: Startup finished in 12.079s (kernel) + 56.095s (userspace) = 1min 8.174s. Oct 30 08:31:08 top-core-1 volumio[800]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 30 08:31:08 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 30 08:31:08 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 08:31:08 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 08:31:08 top-core-1 volumio[800]: info: Starting MyVolumio Remote Streaming Endpoints Oct 30 08:31:08 top-core-1 volumio[800]: info: MyVolumio login type: Token Oct 30 08:31:08 top-core-1 volumio[800]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 30 08:31:08 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 30 08:31:09 top-core-1 volumio[800]: info: Starting Streaming Service Transparent Proxy Oct 30 08:31:09 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 30 08:31:09 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 30 08:31:09 top-core-1 volumio[800]: info: Streaming services startup Oct 30 08:31:09 top-core-1 volumio[800]: info: Starting Streaming Daemon Oct 30 08:31:09 top-core-1 sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 30 08:31:09 top-core-1 sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 08:31:09 top-core-1 volumio[800]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 30 08:31:09 top-core-1 sudo[1330]: pam_unix(sudo:session): session closed for user root Oct 30 08:31:09 top-core-1 volumio[800]: info: Discovery: this is already registered, 9c851e8b-5c4f-4f49-a258-2391803e1255 Oct 30 08:31:09 top-core-1 volumio[800]: info: Discovery: Found device Top Core 1 Oct 30 08:31:09 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:31:09 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:31:09 top-core-1 volumio[800]: error: Cannot start Volumio Streaming Daemon Oct 30 08:31:09 top-core-1 volumio[800]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 30 08:31:09 top-core-1 volumio[800]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 30 08:31:10 top-core-1 volumio[800]: error: MyVolumio Custom Token format not valid, refreshing it Oct 30 08:31:10 top-core-1 volumio[800]: STREAMING PROXY: Starting server on port 3245 Oct 30 08:31:10 top-core-1 volumio[800]: Node JS runtime: 14 Oct 30 08:31:11 top-core-1 volumio[800]: info: MyVolumio login type: Token Oct 30 08:31:12 top-core-1 volumio[800]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 30 08:31:13 top-core-1 volumio[800]: info: MyVolumio token set successfully Oct 30 08:31:13 top-core-1 volumio[800]: info: MYVOLUMIO: Adding device Oct 30 08:31:13 top-core-1 volumio[800]: info: MYVOLUMIO: Evaluating Server Oct 30 08:31:13 top-core-1 volumio[800]: info: MyVolumio status changed Oct 30 08:31:13 top-core-1 volumio[800]: info: Streaming services startup Oct 30 08:31:13 top-core-1 volumio[800]: info: Starting Streaming Daemon Oct 30 08:31:13 top-core-1 volumio[800]: info: Removing browser output: myVolumio user plan is not superstar Oct 30 08:31:13 top-core-1 volumio[800]: info: Removing audio output: Oct 30 08:31:13 top-core-1 volumio[800]: info: Stoppping Tunnel 1 Oct 30 08:31:13 top-core-1 sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 30 08:31:13 top-core-1 sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 08:31:13 top-core-1 sudo[1369]: pam_unix(sudo:session): session closed for user root Oct 30 08:31:13 top-core-1 volumio[800]: error: Cannot start Volumio Streaming Daemon Oct 30 08:31:13 top-core-1 volumio[800]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 30 08:31:13 top-core-1 volumio[800]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 30 08:31:13 top-core-1 sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 30 08:31:13 top-core-1 sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 08:31:13 top-core-1 sudo[1372]: pam_unix(sudo:session): session closed for user root Oct 30 08:31:13 top-core-1 volumio[800]: info: Remote SSH Stopped Oct 30 08:31:14 top-core-1 volumio[800]: info: Setting Geolocation for MyVolumio to as1 Oct 30 08:31:14 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 08:31:14 top-core-1 volumio[800]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 30 08:31:14 top-core-1 volumio[800]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.832&uuid=2828023b725cbe08aa342e4f8b95fbdc" http://updates.volumio.org/downloader-v1/track-device Oct 30 08:31:14 top-core-1 volumio[800]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 30 08:31:14 top-core-1 volumio[800]: Dload Upload Total Spent Left Speed Oct 30 08:31:14 top-core-1 volumio[800]: [1.6K blob data] Oct 30 08:31:14 top-core-1 volumio[800]: retrying in 5 seconds, trial 2 Oct 30 08:31:14 top-core-1 volumio[800]: info: Volumio Calling Home Oct 30 08:31:15 top-core-1 volumio[800]: info: Updating MyVolumio device info Oct 30 08:31:15 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 08:31:15 top-core-1 volumiologrotate[545]: ls: cannot access '/var/log/samba/log.wb-TOP': No such file or directory Oct 30 08:31:15 top-core-1 volumiologrotate[545]: ls: cannot access 'CORE': No such file or directory Oct 30 08:31:15 top-core-1 volumiologrotate[545]: ls: cannot access '1': No such file or directory Oct 30 08:31:15 top-core-1 volumio[800]: info: Volumio called home Oct 30 08:31:15 top-core-1 volumio[800]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 30 08:31:18 top-core-1 volumio[800]: info: MYVOLUMIO: Adding device Oct 30 08:31:18 top-core-1 volumio[800]: info: MYVOLUMIO: Evaluating Server Oct 30 08:31:19 top-core-1 volumio[800]: info: Setting Geolocation for MyVolumio to as1 Oct 30 08:31:19 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 08:31:20 top-core-1 volumio[800]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Oct 30 08:31:20 top-core-1 volumio[800]: info: Updating MyVolumio device info Oct 30 08:31:20 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 30 08:31:21 top-core-1 volumio[800]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Oct 30 08:31:21 top-core-1 volumio[1037]: ...........................................................................................................................................................................................................................................................................................................................................................................................................................................................................++++ Oct 30 08:31:22 top-core-1 ntpd[753]: Soliciting pool server 221.151.118.78 Oct 30 08:31:23 top-core-1 ntpd[753]: Soliciting pool server 121.174.142.82 Oct 30 08:31:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 30 08:31:23 top-core-1 volumio[800]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 30 08:31:23 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:31:23 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:31:25 top-core-1 ntpd[753]: Soliciting pool server 175.210.18.47 Oct 30 08:31:25 top-core-1 ntpd[753]: Soliciting pool server 193.123.243.2 Oct 30 08:31:26 top-core-1 ntpd[753]: Soliciting pool server 121.174.142.81 Oct 30 08:31:26 top-core-1 ntpd[753]: Soliciting pool server 203.32.26.46 Oct 30 08:31:27 top-core-1 ntpd[753]: Soliciting pool server 2401:c080:1c00:24a1:5400:5ff:fe04:720 Oct 30 08:31:27 top-core-1 ntpd[753]: Soliciting pool server 194.0.5.123 Oct 30 08:31:28 top-core-1 ntpd[753]: Soliciting pool server 175.195.167.194 Oct 30 08:31:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 30 08:31:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 30 08:31:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 30 08:31:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 30 08:31:28 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetBrowseSources Oct 30 08:31:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 30 08:31:30 top-core-1 ntpd[753]: receive: Unexpected origin timestamp 0xecad2251.6785e743 does not match aorg 0000000000.00000000 from server@203.32.26.46 xmt 0xecad2252.49337014 Oct 30 08:31:37 top-core-1 systemd[1]: systemd-timedated.service: Succeeded. Oct 30 08:31:45 top-core-1 volumio[1037]: .......................................................................................................................................................................................................................................................................++++ Oct 30 08:31:45 top-core-1 volumio[1037]: e is 65537 (0x010001) Oct 30 08:31:45 top-core-1 volumio[1037]: writing RSA key Oct 30 08:32:14 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 08:32:14 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 08:32:14 top-core-1 volumio[800]: info: Discovery: Getting this device information Oct 30 08:32:14 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:14 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:14 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 08:32:14 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100:3000 from 192.168.8.101 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Oct 30 08:32:14 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:14 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:14 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 30 08:32:14 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 30 08:32:15 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:15 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:16 top-core-1 volumiologrotate[545]: ls: cannot access '/var/log/samba/log.wb-TOP': No such file or directory Oct 30 08:32:16 top-core-1 volumiologrotate[545]: ls: cannot access 'CORE': No such file or directory Oct 30 08:32:16 top-core-1 volumiologrotate[545]: ls: cannot access '1': No such file or directory Oct 30 08:32:17 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100:3000 from 192.168.8.101 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Oct 30 08:32:17 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:17 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:17 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 30 08:32:17 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 30 08:32:17 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:17 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:20 top-core-1 sudo[1583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 30 08:32:20 top-core-1 sudo[1583]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 08:32:20 top-core-1 sudo[1583]: pam_unix(sudo:session): session closed for user root Oct 30 08:32:20 top-core-1 sudo[1585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 30 08:32:20 top-core-1 sudo[1585]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 08:32:20 top-core-1 sudo[1585]: pam_unix(sudo:session): session closed for user root Oct 30 08:32:20 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 30 08:32:21 top-core-1 sudo[1589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 30 08:32:21 top-core-1 sudo[1589]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 08:32:21 top-core-1 sudo[1589]: pam_unix(sudo:session): session closed for user root Oct 30 08:32:21 top-core-1 sudo[1591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 30 08:32:21 top-core-1 sudo[1591]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 08:32:21 top-core-1 sudo[1591]: pam_unix(sudo:session): session closed for user root Oct 30 08:32:22 top-core-1 volumio[800]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.101 UA: Mozilla/5.0 (Linux; Android 13; SM-A325N Build/TP1A.220624.014; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.97 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 30 08:32:22 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 30 08:32:22 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetVisibleSources Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:23 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 30 08:32:23 top-core-1 volumio[800]: info: Received Get System Info Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 08:32:23 top-core-1 volumio[800]: info: Discovery: Getting this device information Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:23 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:23 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:23 top-core-1 volumio[800]: info: Listing playlists Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 30 08:32:23 top-core-1 volumio[800]: info: Received Get System Info Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 08:32:23 top-core-1 volumio[800]: info: Discovery: Getting this device information Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:23 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 08:32:23 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 30 08:32:24 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 30 08:32:26 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 30 08:32:26 top-core-1 volumio[800]: info: Received Get System Info Oct 30 08:32:26 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 08:32:26 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 08:32:26 top-core-1 volumio[800]: info: Discovery: Getting this device information Oct 30 08:32:26 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:26 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:26 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 30 08:32:27 top-core-1 volumio[800]: info: Received Get System Info Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 08:32:27 top-core-1 volumio[800]: info: Discovery: Getting this device information Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:27 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 30 08:32:27 top-core-1 volumio[800]: info: Received Get System Info Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 30 08:32:27 top-core-1 volumio[800]: info: Discovery: Getting this device information Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetState Oct 30 08:32:27 top-core-1 volumio[800]: info: CorePlayQueue::getTrack 0 Oct 30 08:32:27 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 08:32:28 top-core-1 volumio[800]: info: Retrieving Cloud Streaming UI Oct 30 08:32:28 top-core-1 volumio[800]: info: Getting Tidal Cloud Configuration Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 08:32:28 top-core-1 volumio[800]: info: Getting Qobuz Cloud Configuration Oct 30 08:32:28 top-core-1 volumio[800]: info: Asking plugin for UI Config Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 08:32:28 top-core-1 volumio[800]: info: Getting Spotify Cloud Configuration Oct 30 08:32:28 top-core-1 volumio[800]: info: Asking plugin for UI Config Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 08:32:28 top-core-1 volumio[800]: info: Saving Spotify Acccount Oct 30 08:32:28 top-core-1 volumio[800]: info: Got Tidal Cloud Configuration Oct 30 08:32:28 top-core-1 volumio[800]: info: Got it Oct 30 08:32:28 top-core-1 volumio[800]: info: Got it Oct 30 08:32:28 top-core-1 volumio[800]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 30 08:32:28 top-core-1 volumio[800]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetBrowseSources Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetBrowseSources Oct 30 08:32:28 top-core-1 volumio[800]: info: CoreCommandRouter::volumioGetBrowseSources Oct 30 08:32:29 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 30 08:32:29 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 30 08:32:31 top-core-1 volumio[800]: info: Disabling MyMusic plugin upnp Oct 30 08:32:31 top-core-1 sudo[1609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 30 08:32:31 top-core-1 sudo[1609]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 30 08:32:31 top-core-1 systemd[1]: Stopping UPnP Renderer front-end to MPD... Oct 30 08:32:32 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 30 08:32:32 top-core-1 volumio[800]: info: Enabling MyMusic plugin upnp Oct 30 08:32:32 top-core-1 volumio[800]: info: Enabling plugin upnp Oct 30 08:32:32 top-core-1 volumio[800]: info: Loading plugin "upnp"... Oct 30 08:32:32 top-core-1 volumio[800]: info: [1761780752148] Starting Upmpd Daemon Oct 30 08:32:32 top-core-1 volumio[800]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 30 08:32:32 top-core-1 volumio[800]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 08:32:32 top-core-1 volumio[800]: Error: listen EADDRINUSE: address already in use :::6599 Oct 30 08:32:32 top-core-1 volumio[800]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Oct 30 08:32:32 top-core-1 volumio[800]: at listenInCluster (net.js:1366:12) Oct 30 08:32:32 top-core-1 volumio[800]: at Server.listen (net.js:1452:7) Oct 30 08:32:32 top-core-1 volumio[800]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 30 08:32:32 top-core-1 volumio[800]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 30 08:32:32 top-core-1 volumio[800]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 30 08:32:32 top-core-1 volumio[800]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 30 08:32:32 top-core-1 volumio[800]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Oct 30 08:32:32 top-core-1 volumio[800]: code: 'EADDRINUSE', Oct 30 08:32:32 top-core-1 volumio[800]: errno: -98, Oct 30 08:32:32 top-core-1 volumio[800]: syscall: 'listen', Oct 30 08:32:32 top-core-1 volumio[800]: address: '::', Oct 30 08:32:32 top-core-1 volumio[800]: port: 6599 Oct 30 08:32:32 top-core-1 volumio[800]: } Oct 30 08:32:32 top-core-1 volumio[800]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 30 08:32:32 top-core-1 sudo[1620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-30 08:31 Oct 30 08:32:32 top-core-1 sudo[1620]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"