-- Logs begin at Fri 2026-10-16 07:04:42 KST, end at Fri 2026-10-16 07:06:05 KST. -- Oct 16 07:05:00 volumio sudo[1008]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:00 volumio wireless.js[633]: DHCP IP Oct 16 07:05:00 volumio wireless.js[633]: Start ap Oct 16 07:05:00 volumio wpa_supplicant[1010]: Successfully initialized wpa_supplicant Oct 16 07:05:00 volumio sudo[1011]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Oct 16 07:05:00 volumio sudo[1011]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:00 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 16 07:05:00 volumio dhcpcd[1012]: dev: loaded udev Oct 16 07:05:00 volumio dhcpcd-run-hooks[1021]: wlan0: starting wpa_supplicant Oct 16 07:05:00 volumio volumio-time-update[620]: volumio-time-update-util: Fetching time from Volumio... Oct 16 07:05:00 volumio dhcpcd-run-hooks[1030]: wlan0: failed to start wpa_supplicant Oct 16 07:05:00 volumio dhcpcd-run-hooks[1031]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Oct 16 07:05:00 volumio dhcpcd[1012]: wlan0: connected to Access Point `' Oct 16 07:05:00 volumio dhcpcd[1012]: DUID 00:01:00:01:2c:2b:35:46:b8:27:eb:71:58:d6 Oct 16 07:05:00 volumio dhcpcd[1012]: eth0: IAID eb:71:58:d6 Oct 16 07:05:00 volumio dhcpcd[1012]: eth0: adding address fe80::ba27:ebff:fe71:58d6 Oct 16 07:05:00 volumio dhcpcd[1012]: ipv6_addaddr1: Permission denied Oct 16 07:05:00 volumio dhcpcd[1012]: wlan0: waiting for carrier Oct 16 07:05:00 volumio wpa_supplicant[1025]: wlan0: Trying to associate with SSID 'KT_WiFi_096D' Oct 16 07:05:01 volumio volumio-time-update[620]: volumio-time-update-util: Setting system time to: 2026-10-16 07:05:26 Oct 16 07:05:01 volumio wireless.js[633]: trying... Oct 16 07:05:01 volumio sudo[1050]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2026-10-16 07:05:26 Oct 16 07:05:01 volumio sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:01 volumio sudo[1052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 07:05:01 volumio sudo[1052]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:01 volumio dhcpcd[1012]: wlan0: carrier acquired Oct 16 07:05:01 volumio dhcpcd[1012]: wlan0: connected to Access Point `KT_WiFi_096D' Oct 16 07:05:01 volumio wpa_supplicant[1025]: wlan0: Associated with 10:e6:6b:10:09:72 Oct 16 07:05:01 volumio wpa_supplicant[1025]: wlan0: CTRL-EVENT-CONNECTED - Connection to 10:e6:6b:10:09:72 completed [id=0 id_str=] Oct 16 07:05:01 volumio wpa_supplicant[1025]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 16 07:05:01 volumio wpa_supplicant[1025]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=KR Oct 16 07:05:02 volumio volumio-remote-updater[622]: [2026-10-16 07:05:02] [info] asio async_connect error: system:111 (Connection refused) Oct 16 07:05:02 volumio volumio-remote-updater[622]: [2026-10-16 07:05:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 16 07:05:02 volumio volumio-remote-updater[622]: [2026-10-16 07:05:02] [error] handle_connect error: Underlying Transport Error Oct 16 07:05:03 volumio dhcpcd[1012]: wlan0: IAID eb:24:0d:83 Oct 16 07:05:03 volumio dhcpcd[1012]: wlan0: adding address fe80::ba27:ebff:fe24:d83 Oct 16 07:05:03 volumio dhcpcd[1012]: ipv6_addaddr1: Permission denied Oct 16 07:05:03 volumio dhcpcd[1012]: eth0: soliciting an IPv6 router Oct 16 07:05:03 volumio sudo[1052]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:03 volumio dhcpcd[1012]: eth0: rebinding lease of 172.30.1.6 Oct 16 07:05:03 volumio wireless.js[633]: trying... Oct 16 07:05:03 volumio dbus-daemon[626]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.9' (uid=0 pid=1053 comm="timedatectl set-time 2026-10-16 07:05:26 ") Oct 16 07:05:03 volumio sudo[1058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 07:05:03 volumio sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:03 volumio sudo[1058]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:03 volumio dhcpcd[1012]: wlan0: carrier lost Oct 16 07:05:03 volumio systemd[1]: Starting Time & Date Service... Oct 16 07:05:03 volumio dhcpcd[1012]: wlan0: carrier acquired Oct 16 07:05:03 volumio dhcpcd[1012]: wlan0: IAID eb:24:0d:83 Oct 16 07:05:03 volumio dhcpcd[1012]: eth0: leased 172.30.1.6 for 3600 seconds Oct 16 07:05:03 volumio dhcpcd[1012]: eth0: adding route to 172.30.1.0/24 Oct 16 07:05:03 volumio dhcpcd[1012]: eth0: adding default route via 172.30.1.254 Oct 16 07:05:03 volumio dhcpcd[1012]: forked to background, child pid 1101 Oct 16 07:05:03 volumio sudo[1011]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:03 volumio dbus-daemon[626]: [system] Successfully activated service 'org.freedesktop.timedate1' Oct 16 07:05:03 volumio systemd[1]: Started Time & Date Service. Oct 16 07:05:26 volumio systemd-timedated[1060]: Changed local time to Fri Oct 16 07:05:26 2026 Oct 16 07:05:26 volumio sudo[1050]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:26 volumio volumio-time-update[620]: volumio-time-update-util: System time updated successfully. Oct 16 07:05:26 volumio systemd[1]: Started Volumio Time Update Utility. Oct 16 07:05:26 volumio dhcpcd[1101]: wlan0: soliciting an IPv6 router Oct 16 07:05:26 volumio dhcpcd[1101]: wlan0: rebinding lease of 172.30.1.15 Oct 16 07:05:26 volumio dhcpcd[1101]: wlan0: probing address 172.30.1.15/24 Oct 16 07:05:26 volumio wireless.js[633]: trying... Oct 16 07:05:26 volumio sudo[1103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 07:05:26 volumio sudo[1103]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:26 volumio sudo[1103]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:27 volumio wireless.js[633]: trying... Oct 16 07:05:27 volumio sudo[1106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 07:05:27 volumio sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:27 volumio sudo[1106]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:28 volumio wireless.js[633]: trying... Oct 16 07:05:28 volumio sudo[1109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 07:05:28 volumio sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:28 volumio sudo[1109]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:29 volumio wireless.js[633]: trying... Oct 16 07:05:29 volumio sudo[1112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 07:05:29 volumio sudo[1112]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:29 volumio sudo[1112]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:30 volumio wireless.js[633]: trying... Oct 16 07:05:30 volumio sudo[1115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 07:05:30 volumio sudo[1115]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:30 volumio sudo[1115]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:30 volumio dhcpcd[1101]: wlan0: leased 172.30.1.15 for 3600 seconds Oct 16 07:05:30 volumio avahi-daemon[634]: Joining mDNS multicast group on interface wlan0.IPv4 with address 172.30.1.15. Oct 16 07:05:30 volumio dhcpcd[1101]: wlan0: adding route to 172.30.1.0/24 Oct 16 07:05:30 volumio avahi-daemon[634]: New relevant interface wlan0.IPv4 for mDNS. Oct 16 07:05:30 volumio avahi-daemon[634]: Registering new address record for 172.30.1.15 on wlan0.IPv4. Oct 16 07:05:30 volumio dhcpcd[1101]: wlan0: adding default route via 172.30.1.254 Oct 16 07:05:31 volumio wireless.js[633]: trying... Oct 16 07:05:31 volumio sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Oct 16 07:05:31 volumio sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:31 volumio sudo[1139]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:31 volumio wireless.js[633]: Connected to: ----KT_WiFi_096D Oct 16 07:05:31 volumio wireless.js[633]: ---- Oct 16 07:05:31 volumio sudo[1142]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 07:05:31 volumio sudo[1142]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:31 volumio sudo[1142]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:31 volumio wireless.js[633]: ... joined AP, wlan0 IPv4 is 172.30.1.15, ipV6 is undefined Oct 16 07:05:31 volumio wireless.js[633]: It's done! AP Oct 16 07:05:31 volumio systemd[1]: Started Wireless Services. Oct 16 07:05:31 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Oct 16 07:05:31 volumio systemd[1]: Started Volumio Backend Module. Oct 16 07:05:31 volumio systemd[1]: Started Volumio Cpu Tweaker. Oct 16 07:05:31 volumio systemd[1]: Reached target Multi-User System. Oct 16 07:05:31 volumio systemd[1]: Reached target Graphical Interface. Oct 16 07:05:31 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 16 07:05:31 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 16 07:05:31 volumio volumio-cpu-tweak[1148]: Setting RT Priority for mpd Oct 16 07:05:31 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 16 07:05:31 volumio systemd[1]: Startup finished in 16.702s (kernel) + 29.567s (userspace) = 46.270s. Oct 16 07:05:31 volumio volumio-cpu-tweak[1148]: pid 35's current scheduling policy: SCHED_OTHER Oct 16 07:05:31 volumio volumio-cpu-tweak[1148]: pid 35's current scheduling priority: 0 Oct 16 07:05:31 volumio volumio-cpu-tweak[1148]: Setting MPD Affinity Oct 16 07:05:31 volumio volumio-cpu-tweak[1148]: pid 3's current affinity mask: f Oct 16 07:05:31 volumio volumio-cpu-tweak[1148]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Oct 16 07:05:31 volumio volumio-cpu-tweak[1148]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Oct 16 07:05:32 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Oct 16 07:05:32 volumio ntpd[822]: Listen normally on 4 wlan0 172.30.1.15:123 Oct 16 07:05:32 volumio ntpd[822]: new interface(s) found: waking up resolver Oct 16 07:05:35 volumio volumio-remote-updater[622]: [2026-10-16 07:05:35] [connect] Successful connection Oct 16 07:05:37 volumio volumio[1147]: info: ------------------------------------------- Oct 16 07:05:37 volumio volumio[1147]: info: ----- Volumio3 ---- Oct 16 07:05:37 volumio volumio[1147]: info: ------------------------------------------- Oct 16 07:05:37 volumio volumio[1147]: info: ----- System startup ---- Oct 16 07:05:37 volumio volumio[1147]: info: ------------------------------------------- Oct 16 07:05:37 volumio systemd[1]: systemd-fsckd.service: Succeeded. Oct 16 07:05:39 volumio volumio[1147]: info: MYVOLUMIO Environment detected Oct 16 07:05:39 volumio volumio[1147]: info: Plugin folders cleanup Oct 16 07:05:39 volumio volumio[1147]: info: Scanning into folder /volumio/app/plugins/ Oct 16 07:05:39 volumio volumio[1147]: info: Scanning category audio_interface Oct 16 07:05:39 volumio volumio[1147]: info: Scanning category miscellanea Oct 16 07:05:39 volumio volumio[1147]: info: Scanning category music_service Oct 16 07:05:39 volumio volumio[1147]: info: Scanning category plugins.json Oct 16 07:05:39 volumio volumio[1147]: info: Scanning category system_controller Oct 16 07:05:39 volumio volumio[1147]: info: Scanning category user_interface Oct 16 07:05:39 volumio volumio[1147]: info: Scanning into folder /data/plugins/ Oct 16 07:05:39 volumio volumio[1147]: info: Scanning category music_service Oct 16 07:05:39 volumio volumio[1147]: info: Scanning category system_controller Oct 16 07:05:39 volumio volumio[1147]: info: Plugin folders cleanup completed Oct 16 07:05:39 volumio volumio[1147]: info: ------------------------------------------- Oct 16 07:05:39 volumio volumio[1147]: info: ----- Core plugins startup ---- Oct 16 07:05:39 volumio volumio[1147]: info: ------------------------------------------- Oct 16 07:05:39 volumio volumio[1147]: info: Loading plugins from folder /volumio/app/plugins/ Oct 16 07:05:39 volumio volumio[1147]: info: Adding plugin upnp to MyMusic Plugins Oct 16 07:05:39 volumio volumio[1147]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 16 07:05:39 volumio volumio[1147]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 16 07:05:39 volumio volumio[1147]: info: Loading plugins from folder /data/plugins/ Oct 16 07:05:39 volumio volumio[1147]: info: Loading plugin "system"... Oct 16 07:05:39 volumio volumio[1147]: info: Loading plugin "appearance"... Oct 16 07:05:42 volumio volumio[1147]: info: Loading plugin "network"... Oct 16 07:05:42 volumio volumio[1147]: info: Refreshing Cached IP Addresses Oct 16 07:05:42 volumio sudo[1179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 07:05:42 volumio sudo[1179]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:42 volumio sudo[1179]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:42 volumio sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 07:05:42 volumio sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:42 volumio sudo[1181]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:42 volumio volumio[1147]: info: Loading plugin "services"... Oct 16 07:05:42 volumio volumio[1147]: info: Loading plugin "volumio5onboarding"... Oct 16 07:05:42 volumio sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 16 07:05:42 volumio sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:42 volumio volumio[1147]: info: Loading plugin "alsa_controller"... Oct 16 07:05:42 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 07:05:42 volumio volumio[1147]: info: Loading plugin "wizard"... Oct 16 07:05:42 volumio volumio[1147]: info: Loading plugin "networkfs"... Oct 16 07:05:42 volumio volumio[1147]: info: Starting Udev Watcher for removable devices Oct 16 07:05:42 volumio sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=sktm~dkagh!sy026,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //172.30.1.50/music /mnt/NAS/SSONG Oct 16 07:05:42 volumio sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:42 volumio volumio[1147]: info: Ignoring mount for partition: boot Oct 16 07:05:42 volumio volumio[1147]: info: Ignoring mount for partition: volumio Oct 16 07:05:42 volumio volumio[1147]: info: Ignoring mount for partition: volumio_data Oct 16 07:05:42 volumio volumio[1147]: info: Mounting Device SONG_16 Oct 16 07:05:42 volumio sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/SONG_16 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 16 07:05:42 volumio sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:43 volumio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Oct 16 07:05:43 volumio sudo[1215]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:43 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Oct 16 07:05:43 volumio kernel: Key type cifs.spnego registered Oct 16 07:05:43 volumio kernel: Key type cifs.idmap registered Oct 16 07:05:43 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Oct 16 07:05:43 volumio kernel: CIFS: Attempting to mount //172.30.1.50/music Oct 16 07:05:43 volumio volumio[1147]: info: Mounting Device SONG_32 Oct 16 07:05:43 volumio sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/SONG_32 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 16 07:05:43 volumio sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:43 volumio sudo[1190]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:43 volumio kernel: FAT-fs (sdb1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Oct 16 07:05:43 volumio kernel: FAT-fs (sdb1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Oct 16 07:05:43 volumio sudo[1234]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:43 volumio sudo[1205]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:43 volumio volumio[1147]: info: Mounting Device SY-USB32 Oct 16 07:05:43 volumio sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/SY-USB32 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Oct 16 07:05:43 volumio sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:43 volumio sudo[1246]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:43 volumio kernel: FAT-fs (sdc1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Oct 16 07:05:43 volumio kernel: FAT-fs (sdc1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Oct 16 07:05:43 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 07:05:43 volumio volumio[1147]: info: Loading plugin "volumio_command_line_client"... Oct 16 07:05:43 volumio volumio[1147]: info: Loading plugin "upnp"... Oct 16 07:05:43 volumio volumio[1147]: info: [1792101943568] Starting Upmpd Daemon Oct 16 07:05:43 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 07:05:43 volumio volumio[1147]: info: Loading plugin "my_music"... Oct 16 07:05:43 volumio volumio[1147]: info: Loading plugin "mpd"... Oct 16 07:05:44 volumio volumio[1147]: info: Loading plugin "upnp_browser"... Oct 16 07:05:45 volumio volumio[1147]: info: Starting UPNP Browser Oct 16 07:05:45 volumio volumio[1147]: info: Loading plugin "alarm-clock"... Oct 16 07:05:45 volumio volumio[1147]: info: Plugin airplay_emulation is not enabled Oct 16 07:05:45 volumio volumio[1147]: info: Loading plugin "last_100"... Oct 16 07:05:45 volumio volumio[1147]: info: Loading plugin "webradio"... Oct 16 07:05:46 volumio volumio[1147]: info: Loading plugin "i2s_dacs"... Oct 16 07:05:46 volumio volumio[1147]: info: I2S DAC not set, start Auto-detection Oct 16 07:05:46 volumio volumio[1147]: info: Loading plugin "volumiodiscovery"... Oct 16 07:05:46 volumio volumio[1147]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 07:05:46 volumio volumio[1147]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 07:05:46 volumio volumio[1147]: *** WARNING *** For more information see Oct 16 07:05:46 volumio node[1147]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 07:05:46 volumio volumio[1147]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 07:05:46 volumio volumio[1147]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 07:05:46 volumio volumio[1147]: *** WARNING *** For more information see Oct 16 07:05:46 volumio node[1147]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 07:05:46 volumio node[1147]: *** WARNING *** For more information see Oct 16 07:05:46 volumio node[1147]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 07:05:46 volumio node[1147]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 07:05:46 volumio node[1147]: *** WARNING *** For more information see Oct 16 07:05:46 volumio volumio[1147]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 16 07:05:46 volumio volumio[1147]: info: Discovery: Started advertising with name: Volumio Oct 16 07:05:46 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 07:05:46 volumio volumio[1147]: info: Loading plugin "calmradio"... Oct 16 07:05:48 volumio volumio[1147]: info: Loading plugin "autostart"... Oct 16 07:05:49 volumio volumio[1147]: info: Applying required configuration parameters for plugin autostart Oct 16 07:05:49 volumio volumio[1147]: info: AutoStart - onVolumioStart - read config.json Oct 16 07:05:49 volumio volumio[1147]: info: Loading plugin "outputs"... Oct 16 07:05:49 volumio volumio[1147]: info: Loading plugin "albumart"... Oct 16 07:05:49 volumio volumio[1147]: info: Plugin example_plugin is not enabled Oct 16 07:05:49 volumio volumio[1147]: info: Loading plugin "inputs"... Oct 16 07:05:49 volumio volumio[1147]: info: Loading plugin "updater_comm"... Oct 16 07:05:50 volumio volumio-remote-updater[622]: [2026-10-16 07:05:50] [connect] Successful connection Oct 16 07:05:50 volumio volumio[1147]: info: Plugin mpdemulation is not enabled Oct 16 07:05:50 volumio volumio[1147]: info: Loading plugin "rest_api"... Oct 16 07:05:50 volumio volumio[1147]: info: Loading plugin "websocket"... Oct 16 07:05:50 volumio volumio[1147]: info: Starting Socket.io Server version 2.3.0 Oct 16 07:05:50 volumio volumio[1147]: info: Loading plugin "backup_restore"... Oct 16 07:05:50 volumio volumio[1147]: Forking 3 albumart workers Oct 16 07:05:51 volumio volumio[1147]: info: Applying required configuration parameters for plugin backup_restore Oct 16 07:05:51 volumio volumio[1147]: info: Loading i18n strings for locale ko Oct 16 07:05:51 volumio volumio[1147]: Updating browse sources language Oct 16 07:05:51 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::initPlayerControls Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 07:05:52 volumio volumio[1147]: Express server listening on port 3000 Oct 16 07:05:52 volumio volumio[1147]: [Metrics] WebUI: 17s 214.20ms Oct 16 07:05:52 volumio volumio[1147]: info: CoreStateMachine::resetVolumioState Oct 16 07:05:52 volumio volumio[1147]: info: CoreStateMachine::getcurrentVolume Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 07:05:52 volumio volumio[1147]: info: Volumio Network Manager: Network status updated: 3 Oct 16 07:05:52 volumio volumio[1147]: Starting albumart workers Oct 16 07:05:52 volumio volumio[1147]: Starting albumart workers Oct 16 07:05:52 volumio volumio[1147]: Starting albumart workers Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Oct 16 07:05:52 volumio volumio-remote-updater[622]: [2026-10-16 07:05:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1792101950 101 Oct 16 07:05:52 volumio volumio[1147]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 13 Oct 16 07:05:52 volumio volumio[1147]: info: CoreStateMachine::pushState Oct 16 07:05:52 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Oct 16 07:05:52 volumio volumio[1147]: info: CoreStateMachine::updateTrackBlock Oct 16 07:05:52 volumio volumio[1147]: info: CorePlayQueue::getTrackBlock Oct 16 07:05:52 volumio volumio[1147]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 19 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 20 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 21 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 22 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 24 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 25 Oct 16 07:05:53 volumio volumio[1147]: info: Reloading queue from file Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 26 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 27 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 29 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 30 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 31 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 32 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 33 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 34 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 35 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 36 Oct 16 07:05:53 volumio volumio[1147]: info: CoreStateMachine::pushState Oct 16 07:05:53 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:05:53 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Oct 16 07:05:53 volumio volumio[1147]: info: Setting Device type: Raspberry PI Oct 16 07:05:53 volumio volumio[1147]: info: CoreStateMachine::setRepeat null single undefined Oct 16 07:05:53 volumio volumio[1147]: info: CoreStateMachine::pushState Oct 16 07:05:53 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:05:53 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Oct 16 07:05:53 volumio volumio[1147]: info: CoreStateMachine::setRandom null Oct 16 07:05:53 volumio volumio[1147]: info: CoreStateMachine::pushState Oct 16 07:05:53 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:05:53 volumio volumio[1147]: info: CoreCommandRouter::volumioPushState Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 37 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 38 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 39 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 40 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 41 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 42 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 43 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 44 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 45 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 46 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 47 Oct 16 07:05:53 volumio sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 07:05:53 volumio sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:53 volumio sudo[1318]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:53 volumio sudo[1320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 07:05:53 volumio sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:53 volumio sudo[1320]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 48 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 49 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 50 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 51 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 52 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 53 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.6 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 54 Oct 16 07:05:53 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 55 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 56 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 57 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 58 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 59 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 60 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 61 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 62 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 63 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 64 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 65 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 66 Oct 16 07:05:54 volumio volumio[1147]: info: Discovery: adding 3f3d7f81-b890-4f2d-97ee-3ff0a23b553e Oct 16 07:05:54 volumio volumio[1147]: info: Discovery: Found device Volumio Oct 16 07:05:54 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 16 07:05:54 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 67 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 68 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 69 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 70 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 71 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 72 Oct 16 07:05:54 volumio volumio[1147]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 07:05:54 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 07:05:54 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 16 07:05:54 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:05:54 volumio volumio[1147]: info: CoreCommandRouter::volumioGetQueue Oct 16 07:05:54 volumio volumio[1147]: info: CoreStateMachine::getQueue Oct 16 07:05:54 volumio volumio[1147]: info: CorePlayQueue::getQueue Oct 16 07:05:54 volumio volumio[1147]: info: Listing playlists Oct 16 07:05:54 volumio volumio[1147]: info: Discovery: this is already registered, 3f3d7f81-b890-4f2d-97ee-3ff0a23b553e Oct 16 07:05:54 volumio volumio[1147]: info: Discovery: Found device Volumio Oct 16 07:05:54 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 16 07:05:54 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 73 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 74 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 75 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 76 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 77 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 78 Oct 16 07:05:54 volumio volumio[1147]: info: Completed loading Core Plugins Oct 16 07:05:54 volumio volumio[1147]: info: Preparing to generate the ALSA configuration file Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 79 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 80 Oct 16 07:05:54 volumio volumio[1147]: verbose: New Socket.io Connection to 172.30.1.15 from 172.30.1.65 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/156.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 81 Oct 16 07:05:54 volumio volumio[1147]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 16 07:05:54 volumio volumio[1147]: info: Reading ALSA contributions from plugins. Oct 16 07:05:54 volumio sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 16 07:05:54 volumio sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:54 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Oct 16 07:05:54 volumio sudo[1344]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:54 volumio volumio[1147]: info: Upmpdcli Daemon Started Oct 16 07:05:54 volumio volumio[1147]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 16 07:05:56 volumio systemd[1]: systemd-timedated.service: Succeeded. Oct 16 07:05:58 volumio volumio[1147]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 16 07:05:59 volumio volumio[1147]: info: Asound.conf file unchanged, so no further update is needed Oct 16 07:05:59 volumio volumio[1147]: info: Output device has changed, restarting MPD Oct 16 07:05:59 volumio volumio[1147]: info: ___________ START PLUGINS ___________ Oct 16 07:05:59 volumio sudo[1350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 07:05:59 volumio sudo[1350]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:59 volumio sudo[1350]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:59 volumio sudo[1352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 07:05:59 volumio sudo[1352]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:59 volumio volumio[1147]: info: ControllerMpd::onStart: Initializing MPD Oct 16 07:05:59 volumio volumio[1147]: info: Creating MPD Configuration file Oct 16 07:05:59 volumio sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 16 07:05:59 volumio sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:59 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 07:05:59 volumio volumio[1147]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 07:05:59 volumio sudo[1358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 07:05:59 volumio volumio[1147]: info: [1792101959894] CoreMusicLibrary::Adding element 미디어 서버 Oct 16 07:05:59 volumio sudo[1358]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:59 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 07:05:59 volumio sudo[1358]: pam_unix(sudo:session): session closed for user root Oct 16 07:05:59 volumio sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 07:05:59 volumio sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:05:59 volumio volumio[1147]: info: UPNP Browser: Client initialized successfully Oct 16 07:05:59 volumio volumio[1147]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 07:05:59 volumio volumio[1147]: info: [1792101959961] CoreMusicLibrary::Adding element Last_100 Oct 16 07:05:59 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 07:05:59 volumio volumio[1147]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 07:05:59 volumio volumio[1147]: info: [1792101959969] CoreMusicLibrary::Adding element Webradio Oct 16 07:05:59 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 07:05:59 volumio systemd[1]: Listening on mpd.socket. Oct 16 07:05:59 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 07:05:59 volumio systemd[1]: Starting Music Player Daemon... Oct 16 07:05:59 volumio volumio[1147]: info: Initializing BBC Radios Oct 16 07:06:00 volumio systemd[1]: Started Volumio5 Onboarding Server. Oct 16 07:06:00 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 16 07:06:00 volumio systemd[1]: mpd.service: Succeeded. Oct 16 07:06:00 volumio systemd[1]: Stopped Music Player Daemon. Oct 16 07:06:00 volumio sudo[1356]: pam_unix(sudo:session): session closed for user root Oct 16 07:06:00 volumio systemd[1]: Starting Music Player Daemon... Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: Adding Calm Radio to Browse Sources Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 07:06:00 volumio volumio[1147]: info: [1792101960158] CoreMusicLibrary::Adding element Calm Radio Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 07:06:00 volumio volumio[1147]: Cannot find translation for source Calm Radio Oct 16 07:06:00 volumio volumio[1147]: info: AutoStart - onStart Oct 16 07:06:00 volumio volumio[1147]: info: Volumio Calling Home Oct 16 07:06:00 volumio sudo[1374]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 07:06:00 volumio sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 07:06:00 volumio sudo[1374]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 16 07:06:00 volumio sudo[1374]: pam_unix(sudo:session): session closed for user root Oct 16 07:06:00 volumio volumio[1147]: info: MPD Permissions set Oct 16 07:06:00 volumio volumio[1147]: info: MPD Permissions set Oct 16 07:06:00 volumio volumio[1147]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 82 Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 07:06:00 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 07:06:01 volumio volumio[1147]: info: Volumio called home Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 16 07:06:01 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:06:01 volumio volumio5-onboarding[1372]: time=2026-10-16T07:06:01.245+09:00 level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z Oct 16 07:06:01 volumio volumio[1147]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 83 Oct 16 07:06:01 volumio volumio[1147]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 83 Oct 16 07:06:01 volumio volumio[1147]: info: Received Get System Info Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 07:06:01 volumio volumio[1147]: info: Discovery: Getting this device information Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 16 07:06:01 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 07:06:01 volumio volumio5-onboarding[1372]: time=2026-10-16T07:06:01.386+09:00 level=INFO msg="system info for e9497fcb61b2ddda9c88a297b02641ba" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=3.912 Oct 16 07:06:01 volumio volumio[1147]: info: Received Get System Info Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 07:06:01 volumio volumio[1147]: info: Discovery: Getting this device information Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 16 07:06:01 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 07:06:01 volumio volumio5-onboarding[1372]: time=2026-10-16T07:06:01.431+09:00 level=INFO msg="enabling local network discovery" Oct 16 07:06:01 volumio volumio5-onboarding[1372]: time=2026-10-16T07:06:01.468+09:00 level=INFO msg="enabling BLE discovery" Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 07:06:01 volumio volumio5-onboarding[1372]: time=2026-10-16T07:06:01.651+09:00 level=INFO msg="bootstrapping state" hasInternet=true Oct 16 07:06:01 volumio volumio[1147]: info: Received Get System Info Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 07:06:01 volumio volumio[1147]: info: Discovery: Getting this device information Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetState Oct 16 07:06:01 volumio volumio[1147]: info: CorePlayQueue::getTrack 0 Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 07:06:01 volumio volumio-remote-updater[622]: No test mode Oct 16 07:06:01 volumio volumio-remote-updater[622]: No alpha test mode Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetBrowseSources Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetBrowseSources Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::volumioGetBrowseSources Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 16 07:06:01 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 16 07:06:02 volumio volumio[1147]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 16 07:06:02 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 16 07:06:02 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 07:06:02 volumio volumio5-onboarding[1372]: time=2026-10-16T07:06:02.451+09:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Oct 16 07:06:02 volumio volumio5-onboarding[1372]: time=2026-10-16T07:06:02.453+09:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Oct 16 07:06:02 volumio volumio5-onboarding[1372]: time=2026-10-16T07:06:02.453+09:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Oct 16 07:06:02 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 07:06:02 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 07:06:03 volumio volumio5-onboarding[1372]: time=2026-10-16T07:06:03.286+09:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 16 07:06:04 volumio volumio[1147]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 16 07:06:04 volumio volumio[1147]: verbose: ControllerMpd::sendMpdCommand update Oct 16 07:06:04 volumio volumio[1147]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 07:06:04 volumio volumio[1147]: TypeError: Cannot read property 'then' of undefined Oct 16 07:06:04 volumio volumio[1147]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6) Oct 16 07:06:04 volumio volumio[1147]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1912:15) Oct 16 07:06:04 volumio volumio[1147]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Oct 16 07:06:04 volumio volumio[1147]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1102:26) Oct 16 07:06:04 volumio volumio[1147]: at Socket.emit (events.js:315:20) Oct 16 07:06:04 volumio volumio[1147]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 16 07:06:04 volumio volumio[1147]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 16 07:06:04 volumio volumio[1147]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 07:06:05 volumio sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-16 07:05 Oct 16 07:06:05 volumio sudo[1432]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"