-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-06-07 22:54:14 CEST. -- Jun 07 22:53:00 volumio dbus-daemon[522]: [system] Successfully activated service 'org.freedesktop.hostname1' Jun 07 22:53:00 volumio systemd[1]: Started Hostname Service. Jun 07 22:53:00 volumio ntpd[684]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 07 22:53:00 volumio systemd[1]: systemd-rfkill.service: Succeeded. Jun 07 22:53:00 volumio nmbd[635]: [2025/06/07 22:53:00.363610, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Jun 07 22:53:00 volumio nmbd[635]: started asyncdns process 705 Jun 07 22:53:00 volumio nmbd[635]: [2025/06/07 22:53:00.367415, 0] ../lib/util/become_daemon.c:149(daemon_status) Jun 07 22:53:00 volumio nmbd[635]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Jun 07 22:53:00 volumio nmbd[635]: [2025/06/07 22:53:00.367619, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Jun 07 22:53:00 volumio nmbd[635]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Jun 07 22:53:00 volumio wireless.js[527]: Cleaning previous... Jun 07 22:53:00 volumio sudo[713]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 07 22:53:00 volumio sudo[713]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:00 volumio sudo[713]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:01 volumio sudo[715]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 07 22:53:01 volumio sudo[715]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:01 volumio ntpd[684]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 07 22:53:01 volumio sudo[715]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:01 volumio wireless.js[527]: Stopped aP Jun 07 22:53:01 volumio sudo[722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 07 22:53:01 volumio sudo[722]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:01 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 07 22:53:01 volumio sudo[722]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:01 volumio sudo[724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jun 07 22:53:01 volumio sudo[724]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:01 volumio sudo[724]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:01 volumio sudo[731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 07 22:53:01 volumio sudo[731]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:01 volumio sudo[731]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:01 volumio sudo[733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jun 07 22:53:01 volumio sudo[733]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:02 volumio ntpd[684]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jun 07 22:53:02 volumio sudo[733]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:02 volumio wireless.js[527]: SETTING APPROPRIATE REG DOMAIN: DE Jun 07 22:53:02 volumio sudo[738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jun 07 22:53:02 volumio sudo[738]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:02 volumio sudo[738]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:02 volumio sudo[740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Jun 07 22:53:02 volumio sudo[740]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:02 volumio sudo[740]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:02 volumio wireless.js[527]: SUCCESSFULLY SET NEW REGDOMAIN: DE Jun 07 22:53:02 volumio wireless.js[527]: Start wireless flow Jun 07 22:53:02 volumio wireless.js[527]: Stopped hotspot (if there).. Jun 07 22:53:02 volumio sudo[745]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jun 07 22:53:02 volumio sudo[745]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:02 volumio sudo[745]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:02 volumio sudo[747]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jun 07 22:53:02 volumio sudo[747]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:03 volumio sudo[747]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:03 volumio wireless.js[527]: DHCP IP Jun 07 22:53:03 volumio wireless.js[527]: Start ap Jun 07 22:53:03 volumio wpa_supplicant[749]: Successfully initialized wpa_supplicant Jun 07 22:53:03 volumio sudo[750]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jun 07 22:53:03 volumio sudo[750]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:03 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 07 22:53:03 volumio dhcpcd[751]: dev: loaded udev Jun 07 22:53:03 volumio ntpd[684]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jun 07 22:53:03 volumio dhcpcd-run-hooks[769]: wlan0: starting wpa_supplicant Jun 07 22:53:03 volumio volumio-remote-updater[526]: [2025-06-07 22:53:03] [info] asio async_connect error: system:111 (Connection refused) Jun 07 22:53:03 volumio volumio-remote-updater[526]: [2025-06-07 22:53:03] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 07 22:53:03 volumio volumio-remote-updater[526]: [2025-06-07 22:53:03] [error] handle_connect error: Underlying Transport Error Jun 07 22:53:03 volumio dhcpcd-run-hooks[774]: wlan0: failed to start wpa_supplicant Jun 07 22:53:03 volumio dhcpcd-run-hooks[775]: 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 Jun 07 22:53:03 volumio dhcpcd[751]: wlan0: connected to Access Point `' Jun 07 22:53:03 volumio dhcpcd[751]: no interfaces have a carrier Jun 07 22:53:03 volumio dhcpcd[751]: forked to background, child pid 785 Jun 07 22:53:03 volumio dhcpcd[785]: eth0: waiting for carrier Jun 07 22:53:03 volumio dhcpcd[785]: wlan0: waiting for carrier Jun 07 22:53:03 volumio sudo[750]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:03 volumio wpa_supplicant[773]: wlan0: Trying to associate with SSID 'cDjFg6K3Ck7a;17' Jun 07 22:53:04 volumio wireless.js[527]: trying... Jun 07 22:53:04 volumio bthelper[630]: Changing power off succeeded Jun 07 22:53:04 volumio bthelper[630]: [CHG] Controller B8:27:EB:E9:2A:ED Powered: no Jun 07 22:53:04 volumio bthelper[630]: [CHG] Controller B8:27:EB:E9:2A:ED Discovering: no Jun 07 22:53:04 volumio bthelper[630]: [CHG] Controller B8:27:EB:E9:2A:ED Class: 0x00000000 Jun 07 22:53:04 volumio sudo[788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 07 22:53:04 volumio sudo[788]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:04 volumio sudo[788]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:04 volumio bthelper[630]: [CHG] Controller B8:27:EB:E9:2A:ED Class: 0x0000041c Jun 07 22:53:04 volumio bthelper[630]: Changing power on succeeded Jun 07 22:53:04 volumio dhcpcd[785]: wlan0: carrier acquired Jun 07 22:53:04 volumio dhcpcd[785]: wlan0: connected to Access Point `cDjFg6K3Ck7a;17' Jun 07 22:53:04 volumio wpa_supplicant[773]: wlan0: Associated with dc:15:c8:cd:c8:fc Jun 07 22:53:04 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-CONNECTED - Connection to dc:15:c8:cd:c8:fc completed [id=0 id_str=] Jun 07 22:53:04 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jun 07 22:53:04 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DE Jun 07 22:53:04 volumio dhcpcd[785]: DUID 00:01:00:01:2d:5e:64:93:b8:27:eb:43:80:47 Jun 07 22:53:04 volumio dhcpcd[785]: wlan0: IAID eb:16:d5:12 Jun 07 22:53:04 volumio dhcpcd[785]: wlan0: adding address fe80::c6ff:622d:f027:278d Jun 07 22:53:04 volumio dhcpcd[785]: ipv6_addaddr1: Permission denied Jun 07 22:53:04 volumio dhcpcd[785]: wlan0: carrier lost Jun 07 22:53:04 volumio dhcpcd[785]: wlan0: carrier acquired Jun 07 22:53:04 volumio dhcpcd[785]: wlan0: IAID eb:16:d5:12 Jun 07 22:53:04 volumio dhcpcd[785]: wlan0: soliciting an IPv6 router Jun 07 22:53:05 volumio wireless.js[527]: trying... Jun 07 22:53:05 volumio sudo[809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 07 22:53:05 volumio sudo[809]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:05 volumio sudo[809]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:05 volumio dhcpcd[785]: wlan0: rebinding lease of 192.168.178.40 Jun 07 22:53:05 volumio dhcpcd[785]: wlan0: probing address 192.168.178.40/24 Jun 07 22:53:06 volumio wireless.js[527]: trying... Jun 07 22:53:06 volumio sudo[812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 07 22:53:06 volumio sudo[812]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:06 volumio sudo[812]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:07 volumio wireless.js[527]: trying... Jun 07 22:53:07 volumio sudo[815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 07 22:53:07 volumio sudo[815]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:07 volumio sudo[815]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:08 volumio wireless.js[527]: trying... Jun 07 22:53:08 volumio sudo[818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 07 22:53:08 volumio sudo[818]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:08 volumio sudo[818]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:09 volumio wireless.js[527]: trying... Jun 07 22:53:09 volumio sudo[821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 07 22:53:09 volumio sudo[821]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:09 volumio sudo[821]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:10 volumio wireless.js[527]: trying... Jun 07 22:53:10 volumio sudo[824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 07 22:53:10 volumio sudo[824]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:10 volumio sudo[824]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:10 volumio dhcpcd[785]: wlan0: leased 192.168.178.40 for 864000 seconds Jun 07 22:53:10 volumio avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.40. Jun 07 22:53:10 volumio avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Jun 07 22:53:10 volumio dhcpcd[785]: wlan0: adding route to 192.168.178.0/24 Jun 07 22:53:10 volumio avahi-daemon[530]: Registering new address record for 192.168.178.40 on wlan0.IPv4. Jun 07 22:53:10 volumio dhcpcd[785]: wlan0: adding default route via 192.168.178.1 Jun 07 22:53:10 volumio volumio-remote-updater[526]: [2025-06-07 22:53:10] [info] asio async_connect error: system:111 (Connection refused) Jun 07 22:53:10 volumio volumio-remote-updater[526]: [2025-06-07 22:53:10] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 07 22:53:10 volumio volumio-remote-updater[526]: [2025-06-07 22:53:10] [error] handle_connect error: Underlying Transport Error Jun 07 22:53:11 volumio wireless.js[527]: trying... Jun 07 22:53:11 volumio sudo[848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jun 07 22:53:11 volumio sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:11 volumio sudo[848]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:11 volumio wireless.js[527]: Connected to: ----cDjFg6K3Ck7a;17 Jun 07 22:53:11 volumio wireless.js[527]: ---- Jun 07 22:53:11 volumio sudo[851]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 07 22:53:11 volumio sudo[851]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:11 volumio sudo[851]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:11 volumio wireless.js[527]: ... joined AP, wlan0 IPv4 is 192.168.178.40, ipV6 is undefined Jun 07 22:53:11 volumio wireless.js[527]: It's done! AP Jun 07 22:53:11 volumio systemd[1]: Started Wireless Services. Jun 07 22:53:11 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jun 07 22:53:11 volumio systemd[1]: Started Volumio Backend Module. Jun 07 22:53:11 volumio systemd[1]: Started Volumio Cpu Tweaker. Jun 07 22:53:11 volumio volumio-cpu-tweak[857]: Setting RT Priority for mpd Jun 07 22:53:11 volumio volumio-cpu-tweak[857]: pid 35's current scheduling policy: SCHED_OTHER Jun 07 22:53:11 volumio volumio-cpu-tweak[857]: pid 35's current scheduling priority: 0 Jun 07 22:53:11 volumio volumio-cpu-tweak[857]: Setting MPD Affinity Jun 07 22:53:11 volumio volumio-cpu-tweak[857]: pid 3's current affinity mask: f Jun 07 22:53:11 volumio volumio-cpu-tweak[857]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jun 07 22:53:11 volumio volumio-cpu-tweak[857]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jun 07 22:53:11 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Jun 07 22:53:12 volumio ntpd[684]: Listen normally on 3 wlan0 192.168.178.40:123 Jun 07 22:53:12 volumio ntpd[684]: new interface(s) found: waking up resolver Jun 07 22:53:14 volumio volumio[856]: info: ------------------------------------------- Jun 07 22:53:14 volumio volumio[856]: info: ----- Volumio3 ---- Jun 07 22:53:14 volumio volumio[856]: info: ------------------------------------------- Jun 07 22:53:14 volumio volumio[856]: info: ----- System startup ---- Jun 07 22:53:14 volumio volumio[856]: info: ------------------------------------------- Jun 07 22:53:15 volumio nmbd[635]: [2025/06/07 22:53:15.384491, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 07 22:53:15 volumio systemd[1]: Started Samba NMB Daemon. Jun 07 22:53:15 volumio nmbd[635]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jun 07 22:53:15 volumio volumio[856]: info: MYVOLUMIO Environment detected Jun 07 22:53:15 volumio nmbd[635]: [2025/06/07 22:53:15.409999, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jun 07 22:53:15 volumio nmbd[635]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.40 for name WORKGROUP<1d>. Jun 07 22:53:15 volumio nmbd[635]: This response was from IP 192.168.178.28, reporting an IP address of 192.168.178.28. Jun 07 22:53:15 volumio systemd[1]: Starting Samba Winbind Daemon... Jun 07 22:53:15 volumio volumio[856]: info: Plugin folders cleanup Jun 07 22:53:15 volumio volumio[856]: info: Scanning into folder /volumio/app/plugins/ Jun 07 22:53:15 volumio volumio[856]: info: Scanning category audio_interface Jun 07 22:53:15 volumio volumio[856]: info: Scanning category miscellanea Jun 07 22:53:15 volumio volumio[856]: info: Scanning category music_service Jun 07 22:53:15 volumio volumio[856]: info: Scanning category plugins.json Jun 07 22:53:15 volumio volumio[856]: info: Scanning category system_controller Jun 07 22:53:15 volumio volumio[856]: info: Scanning category user_interface Jun 07 22:53:15 volumio volumio[856]: info: Scanning into folder /data/plugins/ Jun 07 22:53:15 volumio volumio[856]: info: Plugin folders cleanup completed Jun 07 22:53:15 volumio volumio[856]: info: ------------------------------------------- Jun 07 22:53:15 volumio volumio[856]: info: ----- Core plugins startup ---- Jun 07 22:53:15 volumio volumio[856]: info: ------------------------------------------- Jun 07 22:53:15 volumio volumio[856]: info: Loading plugins from folder /volumio/app/plugins/ Jun 07 22:53:15 volumio volumio[856]: info: Adding plugin upnp to MyMusic Plugins Jun 07 22:53:15 volumio volumio[856]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 07 22:53:15 volumio volumio[856]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 07 22:53:15 volumio volumio[856]: info: Loading plugins from folder /data/plugins/ Jun 07 22:53:15 volumio volumio[856]: info: Loading plugin "system"... Jun 07 22:53:15 volumio volumio[856]: info: Loading plugin "appearance"... Jun 07 22:53:15 volumio winbindd[883]: [2025/06/07 22:53:15.842797, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jun 07 22:53:15 volumio winbindd[883]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jun 07 22:53:15 volumio winbindd[883]: [2025/06/07 22:53:15.876736, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 07 22:53:15 volumio winbindd[883]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jun 07 22:53:15 volumio systemd[1]: Started Samba Winbind Daemon. Jun 07 22:53:15 volumio systemd[1]: Starting Samba SMB Daemon... Jun 07 22:53:16 volumio smbd[891]: [2025/06/07 22:53:16.556871, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jun 07 22:53:16 volumio systemd[1]: Started Samba SMB Daemon. Jun 07 22:53:16 volumio systemd[1]: Reached target Multi-User System. Jun 07 22:53:16 volumio systemd[1]: Reached target Graphical Interface. Jun 07 22:53:16 volumio smbd[891]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jun 07 22:53:16 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 07 22:53:16 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 07 22:53:16 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 07 22:53:16 volumio systemd[1]: Startup finished in 10.829s (kernel) + 28.649s (userspace) = 39.478s. Jun 07 22:53:17 volumio volumio[856]: info: Loading plugin "network"... Jun 07 22:53:17 volumio volumio[856]: info: Refreshing Cached IP Addresses Jun 07 22:53:17 volumio sudo[903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 07 22:53:17 volumio sudo[903]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:17 volumio volumio[856]: info: Loading plugin "services"... Jun 07 22:53:17 volumio sudo[905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 07 22:53:17 volumio sudo[903]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:17 volumio sudo[905]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:17 volumio volumio[856]: info: Loading plugin "alsa_controller"... Jun 07 22:53:17 volumio sudo[905]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:17 volumio sudo[908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 07 22:53:17 volumio sudo[908]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:17 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 07 22:53:17 volumio volumio[856]: info: Loading plugin "wizard"... Jun 07 22:53:17 volumio volumio[856]: info: Loading plugin "networkfs"... Jun 07 22:53:17 volumio volumio[856]: info: Starting Udev Watcher for removable devices Jun 07 22:53:17 volumio sudo[914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.38/DiskStation /mnt/NAS/DiskStation Jun 07 22:53:17 volumio sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:17 volumio volumio[856]: info: Ignoring mount for partition: boot Jun 07 22:53:17 volumio volumio[856]: info: Ignoring mount for partition: volumio Jun 07 22:53:17 volumio volumio[856]: info: Ignoring mount for partition: volumio_data Jun 07 22:53:17 volumio volumio[856]: info: Mounting Device USB_DISK Jun 07 22:53:17 volumio sudo[925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_DISK -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 07 22:53:17 volumio sudo[925]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:18 volumio kernel: Key type cifs.spnego registered Jun 07 22:53:18 volumio kernel: Key type cifs.idmap registered Jun 07 22:53:18 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. Jun 07 22:53:18 volumio kernel: CIFS: Attempting to mount \\192.168.178.38\DiskStation Jun 07 22:53:18 volumio kernel: fuse: init (API version 7.37) Jun 07 22:53:18 volumio systemd[1]: Mounting FUSE Control File System... Jun 07 22:53:18 volumio systemd[1]: Mounted FUSE Control File System. Jun 07 22:53:18 volumio ntfs-3g[937]: Version 2017.3.23AR.3 integrated FUSE 28 Jun 07 22:53:18 volumio ntfs-3g[937]: Mounted /dev/sda1 (Read-Write, label "USB DISK", NTFS 3.1) Jun 07 22:53:18 volumio ntfs-3g[937]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 07 22:53:18 volumio ntfs-3g[937]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Jun 07 22:53:18 volumio ntfs-3g[937]: Global ownership and permissions enforced, configuration type 7 Jun 07 22:53:18 volumio sudo[925]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 07 22:53:18 volumio volumio[856]: info: Loading plugin "volumio_command_line_client"... Jun 07 22:53:18 volumio volumio[856]: info: Loading plugin "upnp"... Jun 07 22:53:18 volumio volumio[856]: info: [1749329598379] Starting Upmpd Daemon Jun 07 22:53:18 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 07 22:53:18 volumio volumio[856]: info: Loading plugin "my_music"... Jun 07 22:53:18 volumio volumio[856]: info: Loading plugin "mpd"... Jun 07 22:53:18 volumio sudo[908]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:18 volumio volumio[856]: info: Loading plugin "upnp_browser"... Jun 07 22:53:19 volumio volumio[856]: info: Loading plugin "alarm-clock"... Jun 07 22:53:19 volumio volumio[856]: info: Loading plugin "airplay_emulation"... Jun 07 22:53:19 volumio volumio[856]: info: Starting Shairport Sync Jun 07 22:53:19 volumio volumio[856]: info: Loading plugin "last_100"... Jun 07 22:53:19 volumio volumio[856]: info: Loading plugin "webradio"... Jun 07 22:53:19 volumio volumio[856]: info: Loading plugin "i2s_dacs"... Jun 07 22:53:19 volumio volumio[856]: info: Loading plugin "volumiodiscovery"... Jun 07 22:53:19 volumio volumio[856]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 07 22:53:19 volumio volumio[856]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:53:19 volumio volumio[856]: *** WARNING *** For more information see Jun 07 22:53:19 volumio volumio[856]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 07 22:53:19 volumio node[856]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 07 22:53:19 volumio volumio[856]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:53:19 volumio volumio[856]: *** WARNING *** For more information see Jun 07 22:53:19 volumio node[856]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:53:19 volumio node[856]: *** WARNING *** For more information see Jun 07 22:53:19 volumio node[856]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 07 22:53:19 volumio node[856]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:53:19 volumio node[856]: *** WARNING *** For more information see Jun 07 22:53:19 volumio volumio[856]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 07 22:53:19 volumio volumio[856]: info: Discovery: Started advertising with name: Volumio Jun 07 22:53:19 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 07 22:53:19 volumio volumio[856]: info: Loading plugin "outputs"... Jun 07 22:53:19 volumio volumio[856]: info: Loading plugin "albumart"... Jun 07 22:53:19 volumio volumio[856]: info: Plugin example_plugin is not enabled Jun 07 22:53:19 volumio volumio[856]: info: Loading plugin "inputs"... Jun 07 22:53:20 volumio volumio[856]: info: Loading plugin "updater_comm"... Jun 07 22:53:20 volumio volumio[856]: info: Plugin mpdemulation is not enabled Jun 07 22:53:20 volumio volumio[856]: info: Loading plugin "rest_api"... Jun 07 22:53:20 volumio volumio[856]: info: Loading plugin "websocket"... Jun 07 22:53:20 volumio volumio[856]: info: Loading i18n strings for locale de Jun 07 22:53:20 volumio volumio[856]: Updating browse sources language Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 07 22:53:20 volumio volumio[856]: Forking 3 albumart workers Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::initPlayerControls Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:53:20 volumio volumio[856]: Express server listening on port 3000 Jun 07 22:53:20 volumio volumio[856]: [Metrics] WebUI: 7s 527.15ms Jun 07 22:53:20 volumio volumio[856]: info: CoreStateMachine::resetVolumioState Jun 07 22:53:20 volumio volumio[856]: info: CoreStateMachine::getcurrentVolume Jun 07 22:53:20 volumio volumio[856]: info: CoreCommandRouter::volumioRetrievevolume Jun 07 22:53:20 volumio volumio-remote-updater[526]: [2025-06-07 22:53:20] [connect] Successful connection Jun 07 22:53:21 volumio volumio[856]: verbose: New Socket.io Connection to 192.168.178.40 from 192.168.178.34 UA: Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Total Clients: 1 Jun 07 22:53:21 volumio volumio[856]: info: CoreStateMachine::pushState Jun 07 22:53:21 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Jun 07 22:53:21 volumio volumio[856]: info: CoreStateMachine::updateTrackBlock Jun 07 22:53:21 volumio volumio[856]: info: CorePlayQueue::getTrackBlock Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::volumioRetrievevolume Jun 07 22:53:21 volumio volumio-remote-updater[526]: [2025-06-07 22:53:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749329600 101 Jun 07 22:53:21 volumio volumio[856]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 07 22:53:21 volumio volumio[856]: info: Reloading queue from file Jun 07 22:53:21 volumio volumio[856]: info: CoreStateMachine::setRepeat false single undefined Jun 07 22:53:21 volumio volumio[856]: info: CoreStateMachine::pushState Jun 07 22:53:21 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Jun 07 22:53:21 volumio volumio[856]: info: CoreStateMachine::setRandom false Jun 07 22:53:21 volumio volumio[856]: info: CoreStateMachine::pushState Jun 07 22:53:21 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Jun 07 22:53:21 volumio volumio[856]: info: Setting Device type: Raspberry PI Jun 07 22:53:21 volumio volumio[856]: info: CoreStateMachine::pushState Jun 07 22:53:21 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::volumioPushState Jun 07 22:53:21 volumio volumio[856]: info: Discovery: adding d8de6742-373d-4d88-9fe4-1167f10852a1 Jun 07 22:53:21 volumio volumio[856]: info: Discovery: Found device Volumio Jun 07 22:53:21 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:21 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:21 volumio volumio[856]: Starting albumart workers Jun 07 22:53:21 volumio volumio[856]: Starting albumart workers Jun 07 22:53:21 volumio volumio[856]: Starting albumart workers Jun 07 22:53:22 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:22 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:22 volumio volumio[856]: info: Listing playlists Jun 07 22:53:22 volumio volumio[856]: info: Listing playlists Jun 07 22:53:23 volumio volumio[856]: verbose: New Socket.io Connection to 192.168.178.40 from 192.168.178.34 UA: Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Total Clients: 3 Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::volumioGetVisibleSources Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:23 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::volumioGetQueue Jun 07 22:53:23 volumio volumio[856]: info: CoreStateMachine::getQueue Jun 07 22:53:23 volumio volumio[856]: info: CorePlayQueue::getQueue Jun 07 22:53:23 volumio volumio[856]: info: Listing playlists Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 07 22:53:23 volumio volumio[856]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 07 22:53:23 volumio volumio[856]: info: Received Get System Version Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 07 22:53:23 volumio volumio[856]: info: Received Get System Info Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 07 22:53:23 volumio volumio[856]: info: Discovery: Getting this device information Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:23 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::volumioGetVisibleSources Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:23 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:23 volumio volumio[856]: info: CoreCommandRouter::volumioGetQueue Jun 07 22:53:23 volumio volumio[856]: info: CoreStateMachine::getQueue Jun 07 22:53:23 volumio volumio[856]: info: CorePlayQueue::getQueue Jun 07 22:53:23 volumio volumio[856]: info: Listing playlists Jun 07 22:53:24 volumio sudo[914]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:24 volumio volumio[856]: info: Cannot mount NAS DiskStation at system boot, trial number 1 ,retrying in 5 seconds Jun 07 22:53:24 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 07 22:53:24 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jun 07 22:53:25 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jun 07 22:53:27 volumio sh[419]: timed out Jun 07 22:53:27 volumio dhcpcd[469]: timed out Jun 07 22:53:27 volumio sh[419]: dhcpcd exited Jun 07 22:53:27 volumio dhcpcd[469]: dhcpcd exited Jun 07 22:53:27 volumio sh[419]: ifup: failed to bring up eth0 Jun 07 22:53:27 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jun 07 22:53:27 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jun 07 22:53:28 volumio sudo[1014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 07 22:53:28 volumio sudo[1014]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:28 volumio sudo[1014]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:28 volumio sudo[1016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 07 22:53:28 volumio sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:28 volumio sudo[1016]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:28 volumio sudo[1020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 07 22:53:28 volumio sudo[1020]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:28 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 07 22:53:28 volumio sudo[1020]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:28 volumio volumio[856]: info: Upmpdcli Daemon Started Jun 07 22:53:28 volumio volumio[856]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jun 07 22:53:29 volumio sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.38/DiskStation /mnt/NAS/DiskStation Jun 07 22:53:29 volumio sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:29 volumio kernel: CIFS: Attempting to mount \\192.168.178.38\DiskStation Jun 07 22:53:30 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jun 07 22:53:32 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:32 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:32 volumio volumio[856]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jun 07 22:53:35 volumio sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 07 22:53:35 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:35 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:35 volumio sudo[1033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 07 22:53:35 volumio sudo[1033]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:35 volumio sudo[1033]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:35 volumio volumio[856]: verbose: New Socket.io Connection to 192.168.178.40 from 192.168.178.34 UA: Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Total Clients: 3 Jun 07 22:53:35 volumio sudo[1024]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:35 volumio volumio[856]: info: Cannot mount NAS DiskStation at system boot, trial number 2 ,retrying in 5 seconds Jun 07 22:53:35 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 07 22:53:35 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jun 07 22:53:35 volumio volumio[856]: info: CoreCommandRouter::volumioGetVisibleSources Jun 07 22:53:35 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 07 22:53:35 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:35 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:35 volumio volumio[856]: info: CoreCommandRouter::volumioGetQueue Jun 07 22:53:35 volumio volumio[856]: info: CoreStateMachine::getQueue Jun 07 22:53:35 volumio volumio[856]: info: CorePlayQueue::getQueue Jun 07 22:53:35 volumio volumio[856]: info: Listing playlists Jun 07 22:53:35 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 07 22:53:35 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 07 22:53:35 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 07 22:53:35 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 07 22:53:37 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 07 22:53:38 volumio volumio[856]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jun 07 22:53:40 volumio sudo[1037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.38/DiskStation /mnt/NAS/DiskStation Jun 07 22:53:40 volumio sudo[1037]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:40 volumio kernel: CIFS: Attempting to mount \\192.168.178.38\DiskStation Jun 07 22:53:42 volumio volumio[856]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:42 volumio volumio[856]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:42 volumio volumio[856]: info: Listing playlists Jun 07 22:53:42 volumio volumio[856]: info: Listing playlists Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::volumioGetBrowseSources Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::volumioGetBrowseSources Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::volumioGetBrowseSources Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 07 22:53:45 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 07 22:53:46 volumio sudo[1037]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:46 volumio volumio[856]: info: Cannot mount NAS DiskStation at system boot, trial number 3 ,retrying in 5 seconds Jun 07 22:53:46 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 07 22:53:46 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jun 07 22:53:47 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jun 07 22:53:47 volumio volumio[856]: verbose: ControllerMpd::sendMpdCommand rescan Jun 07 22:53:47 volumio volumio[856]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 22:53:47 volumio volumio[856]: TypeError: Cannot read property 'then' of undefined Jun 07 22:53:47 volumio volumio[856]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6) Jun 07 22:53:47 volumio volumio[856]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15) Jun 07 22:53:47 volumio volumio[856]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Jun 07 22:53:47 volumio volumio[856]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26) Jun 07 22:53:47 volumio volumio[856]: at Socket.emit (events.js:315:20) Jun 07 22:53:47 volumio volumio[856]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jun 07 22:53:47 volumio volumio[856]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jun 07 22:53:47 volumio volumio[856]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 22:53:48 volumio sudo[1053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-07 22:52 Jun 07 22:53:48 volumio sudo[1053]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:48 volumio sudo[1053]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:48 volumio volumio-remote-updater[526]: [2025-06-07 22:53:48] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 07 22:53:48 volumio volumio-remote-updater[526]: [2025-06-07 22:53:48] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 07 22:53:48 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 07 22:53:48 volumio ntfs-3g[937]: Unmounting /dev/sda1 (USB DISK) Jun 07 22:53:48 volumio systemd[1]: media-USB_DISK.mount: Succeeded. Jun 07 22:53:48 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 07 22:53:48 volumio systemd[1]: Started dynamicswap service. Jun 07 22:53:48 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 07 22:53:49 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 07 22:53:49 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jun 07 22:53:49 volumio systemd[1]: Started dynamicswap service. Jun 07 22:53:49 volumio systemd[1]: Stopped Volumio Backend Module. Jun 07 22:53:49 volumio systemd[1]: Started Volumio Backend Module. Jun 07 22:53:49 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 07 22:53:51 volumio volumio[1069]: info: ------------------------------------------- Jun 07 22:53:51 volumio volumio[1069]: info: ----- Volumio3 ---- Jun 07 22:53:51 volumio volumio[1069]: info: ------------------------------------------- Jun 07 22:53:51 volumio volumio[1069]: info: ----- System startup ---- Jun 07 22:53:51 volumio volumio[1069]: info: ------------------------------------------- Jun 07 22:53:51 volumio volumio[1069]: info: MYVOLUMIO Environment detected Jun 07 22:53:51 volumio volumio[1069]: info: Plugin folders cleanup Jun 07 22:53:51 volumio volumio[1069]: info: Scanning into folder /volumio/app/plugins/ Jun 07 22:53:51 volumio volumio[1069]: info: Scanning category audio_interface Jun 07 22:53:51 volumio volumio[1069]: info: Scanning category miscellanea Jun 07 22:53:51 volumio volumio[1069]: info: Scanning category music_service Jun 07 22:53:51 volumio volumio[1069]: info: Scanning category plugins.json Jun 07 22:53:51 volumio volumio[1069]: info: Scanning category system_controller Jun 07 22:53:51 volumio volumio[1069]: info: Scanning category user_interface Jun 07 22:53:51 volumio volumio[1069]: info: Scanning into folder /data/plugins/ Jun 07 22:53:51 volumio volumio[1069]: info: Plugin folders cleanup completed Jun 07 22:53:51 volumio volumio[1069]: info: ------------------------------------------- Jun 07 22:53:51 volumio volumio[1069]: info: ----- Core plugins startup ---- Jun 07 22:53:51 volumio volumio[1069]: info: ------------------------------------------- Jun 07 22:53:51 volumio volumio[1069]: info: Loading plugins from folder /volumio/app/plugins/ Jun 07 22:53:51 volumio volumio[1069]: info: Adding plugin upnp to MyMusic Plugins Jun 07 22:53:51 volumio volumio[1069]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 07 22:53:51 volumio volumio[1069]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 07 22:53:51 volumio volumio[1069]: info: Loading plugins from folder /data/plugins/ Jun 07 22:53:51 volumio volumio[1069]: info: Loading plugin "system"... Jun 07 22:53:51 volumio volumio[1069]: info: Loading plugin "appearance"... Jun 07 22:53:52 volumio volumio[1069]: info: Loading plugin "network"... Jun 07 22:53:52 volumio volumio[1069]: info: Refreshing Cached IP Addresses Jun 07 22:53:52 volumio sudo[1095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 07 22:53:52 volumio sudo[1095]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:52 volumio volumio[1069]: info: Loading plugin "services"... Jun 07 22:53:52 volumio sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 07 22:53:52 volumio sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:52 volumio volumio[1069]: info: Loading plugin "alsa_controller"... Jun 07 22:53:52 volumio sudo[1097]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:52 volumio sudo[1095]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:52 volumio sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 07 22:53:52 volumio sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:53 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 07 22:53:53 volumio volumio[1069]: info: Loading plugin "wizard"... Jun 07 22:53:53 volumio volumio[1069]: info: Loading plugin "networkfs"... Jun 07 22:53:53 volumio volumio[1069]: info: Starting Udev Watcher for removable devices Jun 07 22:53:53 volumio sudo[1106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.38/DiskStation /mnt/NAS/DiskStation Jun 07 22:53:53 volumio sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:53 volumio kernel: CIFS: Attempting to mount \\192.168.178.38\DiskStation Jun 07 22:53:53 volumio volumio[1069]: info: Ignoring mount for partition: boot Jun 07 22:53:53 volumio volumio[1069]: info: Ignoring mount for partition: volumio Jun 07 22:53:53 volumio volumio[1069]: info: Ignoring mount for partition: volumio_data Jun 07 22:53:53 volumio volumio[1069]: info: Mounting Device USB_DISK Jun 07 22:53:53 volumio sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_DISK -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 07 22:53:53 volumio sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:53:53 volumio ntfs-3g[1118]: Version 2017.3.23AR.3 integrated FUSE 28 Jun 07 22:53:53 volumio ntfs-3g[1118]: Mounted /dev/sda1 (Read-Write, label "USB DISK", NTFS 3.1) Jun 07 22:53:53 volumio ntfs-3g[1118]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 07 22:53:53 volumio ntfs-3g[1118]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Jun 07 22:53:53 volumio ntfs-3g[1118]: Global ownership and permissions enforced, configuration type 7 Jun 07 22:53:53 volumio sudo[1114]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:53 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 07 22:53:53 volumio volumio[1069]: info: Loading plugin "volumio_command_line_client"... Jun 07 22:53:53 volumio volumio[1069]: info: Loading plugin "upnp"... Jun 07 22:53:53 volumio volumio[1069]: info: [1749329633383] Starting Upmpd Daemon Jun 07 22:53:53 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 07 22:53:53 volumio volumio[1069]: info: Loading plugin "my_music"... Jun 07 22:53:53 volumio volumio[1069]: info: Loading plugin "mpd"... Jun 07 22:53:53 volumio volumio[1069]: info: Loading plugin "upnp_browser"... Jun 07 22:53:53 volumio volumio-remote-updater[526]: [2025-06-07 22:53:53] [connect] Successful connection Jun 07 22:53:53 volumio sudo[1100]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "alarm-clock"... Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "airplay_emulation"... Jun 07 22:53:54 volumio volumio[1069]: info: Starting Shairport Sync Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "last_100"... Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "webradio"... Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "i2s_dacs"... Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "volumiodiscovery"... Jun 07 22:53:54 volumio volumio[1069]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 07 22:53:54 volumio volumio[1069]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:53:54 volumio volumio[1069]: *** WARNING *** For more information see Jun 07 22:53:54 volumio node[1069]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 07 22:53:54 volumio volumio[1069]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 07 22:53:54 volumio volumio[1069]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:53:54 volumio volumio[1069]: *** WARNING *** For more information see Jun 07 22:53:54 volumio node[1069]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:53:54 volumio node[1069]: *** WARNING *** For more information see Jun 07 22:53:54 volumio node[1069]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 07 22:53:54 volumio node[1069]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:53:54 volumio node[1069]: *** WARNING *** For more information see Jun 07 22:53:54 volumio volumio[1069]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 07 22:53:54 volumio volumio[1069]: info: Discovery: Started advertising with name: Volumio Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "outputs"... Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "albumart"... Jun 07 22:53:54 volumio volumio[1069]: info: Plugin example_plugin is not enabled Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "inputs"... Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "updater_comm"... Jun 07 22:53:54 volumio volumio[1069]: info: Plugin mpdemulation is not enabled Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "rest_api"... Jun 07 22:53:54 volumio volumio[1069]: info: Loading plugin "websocket"... Jun 07 22:53:54 volumio volumio[1069]: info: Loading i18n strings for locale de Jun 07 22:53:54 volumio volumio[1069]: Updating browse sources language Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 07 22:53:54 volumio volumio[1069]: Forking 3 albumart workers Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::initPlayerControls Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:53:54 volumio volumio[1069]: Express server listening on port 3000 Jun 07 22:53:54 volumio volumio[1069]: [Metrics] WebUI: 4s 519.61ms Jun 07 22:53:54 volumio volumio[1069]: info: CoreStateMachine::resetVolumioState Jun 07 22:53:54 volumio volumio[1069]: info: CoreStateMachine::getcurrentVolume Jun 07 22:53:54 volumio volumio[1069]: info: CoreCommandRouter::volumioRetrievevolume Jun 07 22:53:55 volumio volumio[1069]: verbose: New Socket.io Connection to 192.168.178.40 from 192.168.178.34 UA: Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Total Clients: 1 Jun 07 22:53:55 volumio volumio-remote-updater[526]: [2025-06-07 22:53:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749329633 101 Jun 07 22:53:55 volumio volumio[1069]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:55 volumio volumio[1069]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:55 volumio volumio[1069]: info: CoreStateMachine::pushState Jun 07 22:53:55 volumio volumio[1069]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState Jun 07 22:53:55 volumio volumio[1069]: info: CoreStateMachine::updateTrackBlock Jun 07 22:53:55 volumio volumio[1069]: info: CorePlayQueue::getTrackBlock Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::volumioRetrievevolume Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 07 22:53:55 volumio volumio[1069]: info: Reloading queue from file Jun 07 22:53:55 volumio volumio[1069]: info: CoreStateMachine::setRepeat false single undefined Jun 07 22:53:55 volumio volumio[1069]: info: CoreStateMachine::pushState Jun 07 22:53:55 volumio volumio[1069]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState Jun 07 22:53:55 volumio volumio[1069]: info: CoreStateMachine::setRandom false Jun 07 22:53:55 volumio volumio[1069]: info: CoreStateMachine::pushState Jun 07 22:53:55 volumio volumio[1069]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState Jun 07 22:53:55 volumio volumio[1069]: info: CoreStateMachine::pushState Jun 07 22:53:55 volumio volumio[1069]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::volumioPushState Jun 07 22:53:55 volumio volumio[1069]: info: Setting Device type: Raspberry PI Jun 07 22:53:55 volumio volumio[1069]: info: Discovery: adding d8de6742-373d-4d88-9fe4-1167f10852a1 Jun 07 22:53:55 volumio volumio[1069]: info: Discovery: Found device Volumio Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:55 volumio volumio[1069]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:55 volumio volumio[1069]: Starting albumart workers Jun 07 22:53:55 volumio volumio[1069]: verbose: New Socket.io Connection to 192.168.178.40 from 192.168.178.34 UA: Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Total Clients: 3 Jun 07 22:53:55 volumio volumio[1069]: Starting albumart workers Jun 07 22:53:55 volumio volumio[1069]: Starting albumart workers Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 07 22:53:55 volumio volumio[1069]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 07 22:53:55 volumio volumio[1069]: info: Received Get System Version Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 07 22:53:55 volumio volumio[1069]: info: Received Get System Info Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 07 22:53:55 volumio volumio[1069]: info: Discovery: Getting this device information Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:55 volumio volumio[1069]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::volumioGetVisibleSources Jun 07 22:53:55 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 07 22:53:56 volumio volumio[1069]: info: CoreCommandRouter::volumioGetState Jun 07 22:53:56 volumio volumio[1069]: info: CorePlayQueue::getTrack 0 Jun 07 22:53:56 volumio volumio[1069]: info: CoreCommandRouter::volumioGetQueue Jun 07 22:53:56 volumio volumio[1069]: info: CoreStateMachine::getQueue Jun 07 22:53:56 volumio volumio[1069]: info: CorePlayQueue::getQueue Jun 07 22:53:56 volumio volumio[1069]: info: Listing playlists Jun 07 22:53:57 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 07 22:53:59 volumio sudo[1106]: pam_unix(sudo:session): session closed for user root Jun 07 22:53:59 volumio volumio[1069]: info: Cannot mount NAS DiskStation at system boot, trial number 1 ,retrying in 5 seconds Jun 07 22:53:59 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 07 22:53:59 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jun 07 22:53:59 volumio volumio[1069]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jun 07 22:53:59 volumio volumio[1069]: verbose: ControllerMpd::sendMpdCommand update Jun 07 22:53:59 volumio volumio[1069]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 22:53:59 volumio volumio[1069]: TypeError: Cannot read property 'then' of undefined Jun 07 22:53:59 volumio volumio[1069]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6) Jun 07 22:53:59 volumio volumio[1069]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1898:15) Jun 07 22:53:59 volumio volumio[1069]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Jun 07 22:53:59 volumio volumio[1069]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26) Jun 07 22:53:59 volumio volumio[1069]: at Socket.emit (events.js:315:20) Jun 07 22:53:59 volumio volumio[1069]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jun 07 22:53:59 volumio volumio[1069]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jun 07 22:53:59 volumio volumio[1069]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 22:54:00 volumio sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-07 22:53 Jun 07 22:54:00 volumio sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:54:00 volumio sudo[1237]: pam_unix(sudo:session): session closed for user root Jun 07 22:54:00 volumio volumio-remote-updater[526]: [2025-06-07 22:54:00] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 07 22:54:00 volumio volumio-remote-updater[526]: [2025-06-07 22:54:00] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 07 22:54:00 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 07 22:54:00 volumio ntfs-3g[1118]: Unmounting /dev/sda1 (USB DISK) Jun 07 22:54:00 volumio systemd[1]: media-USB_DISK.mount: Succeeded. Jun 07 22:54:00 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 07 22:54:00 volumio systemd[1]: Started dynamicswap service. Jun 07 22:54:00 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 07 22:54:00 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 07 22:54:00 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jun 07 22:54:00 volumio systemd[1]: Started dynamicswap service. Jun 07 22:54:00 volumio systemd[1]: Stopped Volumio Backend Module. Jun 07 22:54:00 volumio systemd[1]: Started Volumio Backend Module. Jun 07 22:54:00 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 07 22:54:02 volumio volumio[1250]: info: ------------------------------------------- Jun 07 22:54:02 volumio volumio[1250]: info: ----- Volumio3 ---- Jun 07 22:54:02 volumio volumio[1250]: info: ------------------------------------------- Jun 07 22:54:02 volumio volumio[1250]: info: ----- System startup ---- Jun 07 22:54:02 volumio volumio[1250]: info: ------------------------------------------- Jun 07 22:54:03 volumio volumio[1250]: info: MYVOLUMIO Environment detected Jun 07 22:54:03 volumio volumio[1250]: info: Plugin folders cleanup Jun 07 22:54:03 volumio volumio[1250]: info: Scanning into folder /volumio/app/plugins/ Jun 07 22:54:03 volumio volumio[1250]: info: Scanning category audio_interface Jun 07 22:54:03 volumio volumio[1250]: info: Scanning category miscellanea Jun 07 22:54:03 volumio volumio[1250]: info: Scanning category music_service Jun 07 22:54:03 volumio volumio[1250]: info: Scanning category plugins.json Jun 07 22:54:03 volumio volumio[1250]: info: Scanning category system_controller Jun 07 22:54:03 volumio volumio[1250]: info: Scanning category user_interface Jun 07 22:54:03 volumio volumio[1250]: info: Scanning into folder /data/plugins/ Jun 07 22:54:03 volumio volumio[1250]: info: Plugin folders cleanup completed Jun 07 22:54:03 volumio volumio[1250]: info: ------------------------------------------- Jun 07 22:54:03 volumio volumio[1250]: info: ----- Core plugins startup ---- Jun 07 22:54:03 volumio volumio[1250]: info: ------------------------------------------- Jun 07 22:54:03 volumio volumio[1250]: info: Loading plugins from folder /volumio/app/plugins/ Jun 07 22:54:03 volumio volumio[1250]: info: Adding plugin upnp to MyMusic Plugins Jun 07 22:54:03 volumio volumio[1250]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 07 22:54:03 volumio volumio[1250]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 07 22:54:03 volumio volumio[1250]: info: Loading plugins from folder /data/plugins/ Jun 07 22:54:03 volumio volumio[1250]: info: Loading plugin "system"... Jun 07 22:54:03 volumio volumio[1250]: info: Loading plugin "appearance"... Jun 07 22:54:04 volumio volumio[1250]: info: Loading plugin "network"... Jun 07 22:54:04 volumio volumio[1250]: info: Refreshing Cached IP Addresses Jun 07 22:54:04 volumio sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 07 22:54:04 volumio sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:54:04 volumio sudo[1276]: pam_unix(sudo:session): session closed for user root Jun 07 22:54:04 volumio sudo[1278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 07 22:54:04 volumio volumio[1250]: info: Loading plugin "services"... Jun 07 22:54:04 volumio sudo[1278]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:54:04 volumio volumio[1250]: info: Loading plugin "alsa_controller"... Jun 07 22:54:04 volumio sudo[1278]: pam_unix(sudo:session): session closed for user root Jun 07 22:54:04 volumio sudo[1281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 07 22:54:04 volumio sudo[1281]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:54:04 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 07 22:54:04 volumio volumio[1250]: info: Loading plugin "wizard"... Jun 07 22:54:04 volumio volumio[1250]: info: Loading plugin "networkfs"... Jun 07 22:54:04 volumio volumio[1250]: info: Starting Udev Watcher for removable devices Jun 07 22:54:04 volumio sudo[1287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.38/DiskStation /mnt/NAS/DiskStation Jun 07 22:54:04 volumio sudo[1287]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:54:04 volumio kernel: CIFS: Attempting to mount \\192.168.178.38\DiskStation Jun 07 22:54:04 volumio volumio[1250]: info: Ignoring mount for partition: boot Jun 07 22:54:04 volumio volumio[1250]: info: Ignoring mount for partition: volumio Jun 07 22:54:04 volumio volumio[1250]: info: Ignoring mount for partition: volumio_data Jun 07 22:54:04 volumio volumio[1250]: info: Mounting Device USB_DISK Jun 07 22:54:04 volumio sudo[1295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_DISK -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 07 22:54:04 volumio sudo[1295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 07 22:54:05 volumio ntfs-3g[1298]: Version 2017.3.23AR.3 integrated FUSE 28 Jun 07 22:54:05 volumio ntfs-3g[1298]: Mounted /dev/sda1 (Read-Write, label "USB DISK", NTFS 3.1) Jun 07 22:54:05 volumio ntfs-3g[1298]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 07 22:54:05 volumio ntfs-3g[1298]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Jun 07 22:54:05 volumio ntfs-3g[1298]: Global ownership and permissions enforced, configuration type 7 Jun 07 22:54:05 volumio sudo[1295]: pam_unix(sudo:session): session closed for user root Jun 07 22:54:05 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 07 22:54:05 volumio volumio[1250]: info: Loading plugin "volumio_command_line_client"... Jun 07 22:54:05 volumio volumio[1250]: info: Loading plugin "upnp"... Jun 07 22:54:05 volumio volumio[1250]: info: [1749329645177] Starting Upmpd Daemon Jun 07 22:54:05 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 07 22:54:05 volumio volumio[1250]: info: Loading plugin "my_music"... Jun 07 22:54:05 volumio volumio[1250]: info: Loading plugin "mpd"... Jun 07 22:54:05 volumio ntpd[684]: Soliciting pool server 194.50.19.117 Jun 07 22:54:05 volumio volumio-remote-updater[526]: [2025-06-07 22:54:05] [connect] Successful connection Jun 07 22:54:05 volumio volumio[1250]: info: Loading plugin "upnp_browser"... Jun 07 22:54:05 volumio sudo[1281]: pam_unix(sudo:session): session closed for user root Jun 07 22:54:05 volumio volumio[1250]: info: Loading plugin "alarm-clock"... Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "airplay_emulation"... Jun 07 22:54:06 volumio volumio[1250]: info: Starting Shairport Sync Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "last_100"... Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "webradio"... Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "i2s_dacs"... Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "volumiodiscovery"... Jun 07 22:54:06 volumio volumio[1250]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 07 22:54:06 volumio volumio[1250]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:54:06 volumio volumio[1250]: *** WARNING *** For more information see Jun 07 22:54:06 volumio volumio[1250]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 07 22:54:06 volumio node[1250]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 07 22:54:06 volumio volumio[1250]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:54:06 volumio volumio[1250]: *** WARNING *** For more information see Jun 07 22:54:06 volumio node[1250]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:54:06 volumio node[1250]: *** WARNING *** For more information see Jun 07 22:54:06 volumio node[1250]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 07 22:54:06 volumio node[1250]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 07 22:54:06 volumio node[1250]: *** WARNING *** For more information see Jun 07 22:54:06 volumio volumio[1250]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 07 22:54:06 volumio volumio[1250]: info: Discovery: Started advertising with name: Volumio Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "outputs"... Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "albumart"... Jun 07 22:54:06 volumio volumio[1250]: info: Plugin example_plugin is not enabled Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "inputs"... Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "updater_comm"... Jun 07 22:54:06 volumio volumio[1250]: info: Plugin mpdemulation is not enabled Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "rest_api"... Jun 07 22:54:06 volumio volumio[1250]: info: Loading plugin "websocket"... Jun 07 22:54:06 volumio volumio[1250]: info: Loading i18n strings for locale de Jun 07 22:54:06 volumio volumio[1250]: Updating browse sources language Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 07 22:54:06 volumio volumio[1250]: Forking 3 albumart workers Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::initPlayerControls Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 07 22:54:06 volumio volumio[1250]: Express server listening on port 3000 Jun 07 22:54:06 volumio volumio[1250]: [Metrics] WebUI: 4s 558.95ms Jun 07 22:54:06 volumio volumio[1250]: info: CoreStateMachine::resetVolumioState Jun 07 22:54:06 volumio volumio[1250]: info: CoreStateMachine::getcurrentVolume Jun 07 22:54:06 volumio volumio[1250]: info: CoreCommandRouter::volumioRetrievevolume Jun 07 22:54:07 volumio volumio[1250]: verbose: New Socket.io Connection to 192.168.178.40 from 192.168.178.34 UA: Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Total Clients: 1 Jun 07 22:54:07 volumio volumio-remote-updater[526]: [2025-06-07 22:54:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1749329645 101 Jun 07 22:54:07 volumio volumio[1250]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::volumioGetState Jun 07 22:54:07 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:07 volumio volumio[1250]: info: CoreStateMachine::pushState Jun 07 22:54:07 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::volumioPushState Jun 07 22:54:07 volumio volumio[1250]: info: CoreStateMachine::updateTrackBlock Jun 07 22:54:07 volumio volumio[1250]: info: CorePlayQueue::getTrackBlock Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::volumioRetrievevolume Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 07 22:54:07 volumio volumio[1250]: info: Reloading queue from file Jun 07 22:54:07 volumio volumio[1250]: info: CoreStateMachine::setRepeat false single undefined Jun 07 22:54:07 volumio volumio[1250]: info: CoreStateMachine::pushState Jun 07 22:54:07 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::volumioPushState Jun 07 22:54:07 volumio volumio[1250]: info: CoreStateMachine::setRandom false Jun 07 22:54:07 volumio volumio[1250]: info: CoreStateMachine::pushState Jun 07 22:54:07 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::volumioPushState Jun 07 22:54:07 volumio volumio[1250]: info: Listing playlists Jun 07 22:54:07 volumio volumio[1250]: info: Listing playlists Jun 07 22:54:07 volumio volumio[1250]: info: Setting Device type: Raspberry PI Jun 07 22:54:07 volumio volumio[1250]: info: CoreStateMachine::pushState Jun 07 22:54:07 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::volumioPushState Jun 07 22:54:07 volumio volumio[1250]: info: Discovery: adding d8de6742-373d-4d88-9fe4-1167f10852a1 Jun 07 22:54:07 volumio volumio[1250]: info: Discovery: Found device Volumio Jun 07 22:54:07 volumio volumio[1250]: info: CoreCommandRouter::volumioGetState Jun 07 22:54:07 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:07 volumio volumio[1250]: Starting albumart workers Jun 07 22:54:07 volumio volumio[1250]: Starting albumart workers Jun 07 22:54:07 volumio volumio[1250]: Starting albumart workers Jun 07 22:54:08 volumio volumio[1250]: verbose: New Socket.io Connection to 192.168.178.40 from 192.168.178.34 UA: Mozilla/5.0 (X11; Linux x86_64; rv:139.0) Gecko/20100101 Firefox/139.0 Total Clients: 3 Jun 07 22:54:08 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 07 22:54:08 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 07 22:54:08 volumio volumio[1250]: info: CoreCommandRouter::volumioGetVisibleSources Jun 07 22:54:08 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 07 22:54:08 volumio volumio[1250]: info: CoreCommandRouter::volumioGetState Jun 07 22:54:08 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:08 volumio volumio[1250]: info: CoreCommandRouter::volumioGetQueue Jun 07 22:54:08 volumio volumio[1250]: info: CoreStateMachine::getQueue Jun 07 22:54:08 volumio volumio[1250]: info: CorePlayQueue::getQueue Jun 07 22:54:08 volumio volumio[1250]: info: Listing playlists Jun 07 22:54:08 volumio ntpd[684]: Soliciting pool server 194.50.19.117 Jun 07 22:54:08 volumio ntpd[684]: Soliciting pool server 78.47.56.71 Jun 07 22:54:09 volumio ntpd[684]: Soliciting pool server 116.203.96.227 Jun 07 22:54:09 volumio ntpd[684]: Soliciting pool server 88.198.53.80 Jun 07 22:54:09 volumio ntpd[684]: Soliciting pool server 176.9.44.212 Jun 07 22:54:09 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 07 22:54:10 volumio ntpd[684]: Soliciting pool server 188.68.34.173 Jun 07 22:54:10 volumio ntpd[684]: Soliciting pool server 107.189.12.98 Jun 07 22:54:10 volumio ntpd[684]: Soliciting pool server 85.220.190.246 Jun 07 22:54:11 volumio sudo[1287]: pam_unix(sudo:session): session closed for user root Jun 07 22:54:11 volumio volumio[1250]: info: Cannot mount NAS DiskStation at system boot, trial number 1 ,retrying in 5 seconds Jun 07 22:54:11 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 07 22:54:11 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jun 07 22:54:11 volumio ntpd[684]: Soliciting pool server 3.121.254.221 Jun 07 22:54:11 volumio ntpd[684]: Soliciting pool server 5.75.181.179 Jun 07 22:54:12 volumio ntpd[684]: Soliciting pool server 109.123.244.54 Jun 07 22:54:12 volumio volumio[1250]: info: CoreCommandRouter::volumioGetState Jun 07 22:54:12 volumio volumio[1250]: info: CorePlayQueue::getTrack 0 Jun 07 22:54:13 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 07 22:54:13 volumio volumio[1250]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Jun 07 22:54:13 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Jun 07 22:54:14 volumio volumio[1250]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Jun 07 22:54:14 volumio volumio[1250]: info: Rebuild Album cache Jun 07 22:54:14 volumio volumio[1250]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 22:54:14 volumio volumio[1250]: TypeError: Cannot read property 'sendCommand' of undefined Jun 07 22:54:14 volumio volumio[1250]: at /volumio/app/plugins/music_service/mpd/index.js:2986:22 Jun 07 22:54:14 volumio volumio[1250]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jun 07 22:54:14 volumio volumio[1250]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 07 22:54:14 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-07 22:53 Jun 07 22:54:14 volumio sudo[1385]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"