-- Logs begin at Thu 2019-02-14 19:11:58 JST, end at Sat 2025-03-08 11:35:29 JST. -- Mar 08 11:34:00 volumio wireless.js[631]: trying... Mar 08 11:34:00 volumio sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 11:34:00 volumio sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:00 volumio sudo[1024]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:01 volumio wireless.js[631]: trying... Mar 08 11:34:01 volumio sudo[1027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 11:34:01 volumio sudo[1027]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:01 volumio sudo[1027]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:02 volumio wireless.js[631]: trying... Mar 08 11:34:02 volumio sudo[1030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 11:34:02 volumio sudo[1030]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:02 volumio sudo[1030]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:02 volumio dhcpcd[964]: wlan0: using static address 192.168.2.126/24 Mar 08 11:34:02 volumio avahi-daemon[637]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.2.126. Mar 08 11:34:02 volumio dhcpcd[964]: wlan0: adding route to 192.168.2.0/24 Mar 08 11:34:02 volumio dhcpcd[964]: wlan0: adding default route via 192.168.2.1 Mar 08 11:34:02 volumio avahi-daemon[637]: New relevant interface wlan0.IPv4 for mDNS. Mar 08 11:34:02 volumio avahi-daemon[637]: Registering new address record for 192.168.2.126 on wlan0.IPv4. Mar 08 11:34:03 volumio wireless.js[631]: trying... Mar 08 11:34:03 volumio sudo[1054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 11:34:03 volumio sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:03 volumio sudo[1054]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:03 volumio wireless.js[631]: Connected to: ----elecom-3b5d8c Mar 08 11:34:03 volumio wireless.js[631]: ---- Mar 08 11:34:03 volumio sudo[1057]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 11:34:03 volumio sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:03 volumio sudo[1057]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:03 volumio wireless.js[631]: ... joined AP, wlan0 IPv4 is 192.168.2.126, ipV6 is undefined Mar 08 11:34:03 volumio wireless.js[631]: It's done! AP Mar 08 11:34:03 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 08 11:34:03 volumio systemd[1]: Started Wireless Services. Mar 08 11:34:03 volumio systemd[1]: Started Volumio Backend Module. Mar 08 11:34:03 volumio systemd[1]: Started Volumio Cpu Tweaker. Mar 08 11:34:03 volumio volumio-cpu-tweak[1063]: Setting RT Priority for mpd Mar 08 11:34:03 volumio volumio-cpu-tweak[1063]: Setting MPD Affinity Mar 08 11:34:03 volumio volumio-cpu-tweak[1063]: pid 824's current affinity mask: f Mar 08 11:34:03 volumio volumio-cpu-tweak[1063]: pid 824's new affinity mask: 3 Mar 08 11:34:03 volumio volumio-cpu-tweak[1063]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 08 11:34:03 volumio volumio-cpu-tweak[1063]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 08 11:34:03 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 08 11:34:04 volumio ntpd[814]: Listen normally on 3 wlan0 192.168.2.126:123 Mar 08 11:34:04 volumio ntpd[814]: new interface(s) found: waking up resolver Mar 08 11:34:04 volumio volumio-time-update[620]: volumio-time-update-util: Fetching time from Volumio... Mar 08 11:34:05 volumio volumio[1062]: info: ------------------------------------------- Mar 08 11:34:05 volumio volumio[1062]: info: ----- Volumio3 ---- Mar 08 11:34:05 volumio volumio[1062]: info: ------------------------------------------- Mar 08 11:34:05 volumio volumio[1062]: info: ----- System startup ---- Mar 08 11:34:05 volumio volumio[1062]: info: ------------------------------------------- Mar 08 11:34:05 volumio volumio-time-update[620]: volumio-time-update-util: Setting system time to: 2025-03-08 11:34:34 Mar 08 11:34:05 volumio sudo[1092]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-08 11:34:34 Mar 08 11:34:05 volumio sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:05 volumio dbus-daemon[612]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.9' (uid=0 pid=1093 comm="timedatectl set-time 2025-03-08 11:34:34 ") Mar 08 11:34:05 volumio systemd[1]: Starting Time & Date Service... Mar 08 11:34:05 volumio volumio[1062]: info: MYVOLUMIO Environment detected Mar 08 11:34:05 volumio dbus-daemon[612]: [system] Successfully activated service 'org.freedesktop.timedate1' Mar 08 11:34:05 volumio systemd[1]: Started Time & Date Service. Mar 08 11:34:34 volumio systemd-timedated[1094]: Changed local time to Sat Mar 8 11:34:34 2025 Mar 08 11:34:34 volumio sudo[1092]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:34 volumio volumio-time-update[620]: volumio-time-update-util: System time updated successfully. Mar 08 11:34:34 volumio systemd[1]: Started Volumio Time Update Utility. Mar 08 11:34:34 volumio volumio[1062]: info: Plugin folders cleanup Mar 08 11:34:34 volumio volumio[1062]: info: Scanning into folder /volumio/app/plugins/ Mar 08 11:34:34 volumio volumio[1062]: info: Scanning category audio_interface Mar 08 11:34:34 volumio volumio[1062]: info: Scanning category miscellanea Mar 08 11:34:34 volumio volumio[1062]: info: Scanning category music_service Mar 08 11:34:34 volumio volumio[1062]: info: Scanning category plugins.json Mar 08 11:34:34 volumio volumio[1062]: info: Scanning category system_controller Mar 08 11:34:34 volumio volumio[1062]: info: Scanning category user_interface Mar 08 11:34:34 volumio volumio[1062]: info: Scanning into folder /data/plugins/ Mar 08 11:34:34 volumio volumio[1062]: info: Plugin folders cleanup completed Mar 08 11:34:34 volumio volumio[1062]: info: ------------------------------------------- Mar 08 11:34:34 volumio volumio[1062]: info: ----- Core plugins startup ---- Mar 08 11:34:34 volumio volumio[1062]: info: ------------------------------------------- Mar 08 11:34:34 volumio volumio[1062]: info: Loading plugins from folder /volumio/app/plugins/ Mar 08 11:34:34 volumio volumio[1062]: info: Adding plugin upnp to MyMusic Plugins Mar 08 11:34:34 volumio volumio[1062]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 08 11:34:34 volumio volumio[1062]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 08 11:34:34 volumio volumio[1062]: info: Loading plugins from folder /data/plugins/ Mar 08 11:34:34 volumio volumio[1062]: info: Loading plugin "system"... Mar 08 11:34:34 volumio volumio[1062]: info: Loading plugin "appearance"... Mar 08 11:34:34 volumio nmbd[800]: [2025/03/08 11:34:34.567981, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 08 11:34:34 volumio systemd[1]: Started Samba NMB Daemon. Mar 08 11:34:34 volumio nmbd[800]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 08 11:34:34 volumio systemd[1]: Starting Samba Winbind Daemon... Mar 08 11:34:34 volumio winbindd[1100]: [2025/03/08 11:34:34.861186, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 08 11:34:34 volumio winbindd[1100]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 08 11:34:34 volumio winbindd[1100]: [2025/03/08 11:34:34.908094, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 08 11:34:34 volumio systemd[1]: Started Samba Winbind Daemon. Mar 08 11:34:34 volumio winbindd[1100]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 08 11:34:34 volumio systemd[1]: Starting Samba SMB Daemon... Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "network"... Mar 08 11:34:35 volumio volumio[1062]: info: Refreshing Cached IP Addresses Mar 08 11:34:35 volumio sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 08 11:34:35 volumio sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:35 volumio sudo[1107]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:35 volumio sudo[1109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 11:34:35 volumio sudo[1109]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:35 volumio sudo[1109]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "services"... Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "alsa_controller"... Mar 08 11:34:35 volumio sudo[1120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 08 11:34:35 volumio sudo[1120]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "wizard"... Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "networkfs"... Mar 08 11:34:35 volumio volumio[1062]: info: Starting Udev Watcher for removable devices Mar 08 11:34:35 volumio sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=yokoyama,password=03BB5P2K,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.128/disk1\\music /mnt/NAS/disk1 Mar 08 11:34:35 volumio sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:35 volumio sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=yokoyama,password=03BB5P2K,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.128/disk1 /mnt/NAS/disk1 Mar 08 11:34:35 volumio sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:35 volumio volumio-remote-updater[624]: [2025-03-08 11:34:35] [connect] Successful connection Mar 08 11:34:35 volumio volumio[1062]: info: Ignoring mount for partition: boot Mar 08 11:34:35 volumio volumio[1062]: info: Ignoring mount for partition: volumio Mar 08 11:34:35 volumio volumio[1062]: info: Ignoring mount for partition: volumio_data Mar 08 11:34:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "volumio_command_line_client"... Mar 08 11:34:35 volumio smbd[1105]: [2025/03/08 11:34:35.406367, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 08 11:34:35 volumio systemd[1]: Started Samba SMB Daemon. Mar 08 11:34:35 volumio smbd[1105]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 08 11:34:35 volumio systemd[1]: Reached target Multi-User System. Mar 08 11:34:35 volumio systemd[1]: Reached target Graphical Interface. Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "upnp"... Mar 08 11:34:35 volumio volumio[1062]: info: [1741401275423] Starting Upmpd Daemon Mar 08 11:34:35 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "my_music"... Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "mpd"... Mar 08 11:34:35 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 08 11:34:35 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 08 11:34:35 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 08 11:34:35 volumio systemd[1]: Startup finished in 12.568s (kernel) + 26.350s (userspace) = 38.919s. Mar 08 11:34:35 volumio kernel: Key type cifs.spnego registered Mar 08 11:34:35 volumio kernel: Key type cifs.idmap registered Mar 08 11:34:35 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. Mar 08 11:34:35 volumio kernel: CIFS: Attempting to mount //192.168.2.128/disk1/music Mar 08 11:34:35 volumio kernel: cryptd: max_cpu_qlen set to 1000 Mar 08 11:34:35 volumio volumio[1062]: info: Loading plugin "upnp_browser"... Mar 08 11:34:35 volumio sudo[1139]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:35 volumio kernel: CIFS: Attempting to mount //192.168.2.128/disk1 Mar 08 11:34:36 volumio sudo[1141]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "alarm-clock"... Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "airplay_emulation"... Mar 08 11:34:36 volumio volumio[1062]: info: Starting Shairport Sync Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "last_100"... Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "webradio"... Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "i2s_dacs"... Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "volumiodiscovery"... Mar 08 11:34:36 volumio volumio[1062]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 08 11:34:36 volumio volumio[1062]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 11:34:36 volumio volumio[1062]: *** WARNING *** For more information see Mar 08 11:34:36 volumio volumio[1062]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 08 11:34:36 volumio volumio[1062]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 11:34:36 volumio volumio[1062]: *** WARNING *** For more information see Mar 08 11:34:36 volumio node[1062]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 08 11:34:36 volumio node[1062]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 11:34:36 volumio node[1062]: *** WARNING *** For more information see Mar 08 11:34:36 volumio node[1062]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 08 11:34:36 volumio node[1062]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 11:34:36 volumio node[1062]: *** WARNING *** For more information see Mar 08 11:34:36 volumio volumio[1062]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 08 11:34:36 volumio volumio[1062]: info: Discovery: Started advertising with name: Volumio Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "outputs"... Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "albumart"... Mar 08 11:34:36 volumio volumio[1062]: info: Plugin example_plugin is not enabled Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "inputs"... Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "updater_comm"... Mar 08 11:34:36 volumio volumio[1062]: info: Plugin mpdemulation is not enabled Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "rest_api"... Mar 08 11:34:36 volumio volumio[1062]: info: Loading plugin "websocket"... Mar 08 11:34:36 volumio volumio[1062]: Forking 3 albumart workers Mar 08 11:34:36 volumio volumio[1062]: info: Starting Socket.io Server version 2.3.0 Mar 08 11:34:36 volumio volumio[1062]: info: Loading i18n strings for locale ja Mar 08 11:34:36 volumio volumio[1062]: Updating browse sources language Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::initPlayerControls Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 11:34:36 volumio volumio[1062]: Express server listening on port 3000 Mar 08 11:34:36 volumio volumio[1062]: [Metrics] WebUI: 4s 216.20ms Mar 08 11:34:36 volumio volumio[1062]: info: CoreStateMachine::resetVolumioState Mar 08 11:34:36 volumio volumio[1062]: info: CoreStateMachine::getcurrentVolume Mar 08 11:34:36 volumio volumio[1062]: info: CoreCommandRouter::volumioRetrievevolume Mar 08 11:34:37 volumio volumio[1062]: info: Volumio Network Manager: Network status updated: 2 Mar 08 11:34:37 volumio volumio[1062]: verbose: New Socket.io Connection to 192.168.2.126 from 192.168.2.135 UA: Mozilla/5.0 (Linux; Android 12; moto g52j 5G Build/S3RYBS32.168-19-5-17; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Mar 08 11:34:37 volumio volumio-remote-updater[624]: [2025-03-08 11:34:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741401275 101 Mar 08 11:34:37 volumio volumio[1062]: 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: 2 Mar 08 11:34:37 volumio volumio[1062]: Starting albumart workers Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:34:37 volumio volumio[1062]: info: Reloading queue from file Mar 08 11:34:37 volumio volumio[1062]: info: CoreStateMachine::setRepeat null single undefined Mar 08 11:34:37 volumio volumio[1062]: info: CoreStateMachine::pushState Mar 08 11:34:37 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Mar 08 11:34:37 volumio volumio[1062]: info: CoreStateMachine::setRandom null Mar 08 11:34:37 volumio volumio[1062]: info: CoreStateMachine::pushState Mar 08 11:34:37 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Mar 08 11:34:37 volumio volumio[1062]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 08 11:34:37 volumio volumio[1062]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Mar 08 11:34:37 volumio volumio[1062]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 08 11:34:37 volumio volumio[1062]: Starting albumart workers Mar 08 11:34:37 volumio volumio[1062]: Starting albumart workers Mar 08 11:34:37 volumio volumio[1062]: info: VolumeController:: Volume=100 Mute =false Mar 08 11:34:37 volumio volumio[1062]: info: CoreStateMachine::pushState Mar 08 11:34:37 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Mar 08 11:34:37 volumio volumio[1062]: info: CoreStateMachine::updateTrackBlock Mar 08 11:34:37 volumio volumio[1062]: info: CorePlayQueue::getTrackBlock Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::volumioRetrievevolume Mar 08 11:34:37 volumio volumio[1062]: info: Setting Device type: Raspberry PI Mar 08 11:34:37 volumio volumio[1062]: info: Completed loading Core Plugins Mar 08 11:34:37 volumio volumio[1062]: info: Preparing to generate the ALSA configuration file Mar 08 11:34:37 volumio volumio[1062]: info: Asound.conf file unchanged, so no further update is needed Mar 08 11:34:37 volumio volumio[1062]: info: Output device has changed, restarting MPD Mar 08 11:34:37 volumio volumio[1062]: info: Output device has changed, restarting Shairport Sync Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:34:37 volumio sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 08 11:34:37 volumio sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:37 volumio sudo[1235]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:37 volumio sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 08 11:34:37 volumio sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:37 volumio systemd[1]: Stopping Music Player Daemon... Mar 08 11:34:37 volumio volumio[1062]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 08 11:34:37 volumio volumio[1062]: info: ___________ START PLUGINS ___________ Mar 08 11:34:37 volumio volumio[1062]: info: ControllerMpd::onStart: Initializing MPD Mar 08 11:34:37 volumio volumio[1062]: info: Creating MPD Configuration file Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 11:34:37 volumio volumio[1062]: info: [1741401277606] CoreMusicLibrary::Adding element DLNAサーバー Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:34:37 volumio systemd[1]: mpd.service: Succeeded. Mar 08 11:34:37 volumio systemd[1]: Stopped Music Player Daemon. Mar 08 11:34:37 volumio sudo[1244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 08 11:34:37 volumio sudo[1244]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:37 volumio sudo[1244]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:37 volumio volumio[1062]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:34:37 volumio sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 08 11:34:37 volumio systemd[1]: Starting Music Player Daemon... Mar 08 11:34:37 volumio sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:37 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 08 11:34:37 volumio systemd[1]: mpd.service: Succeeded. Mar 08 11:34:37 volumio systemd[1]: Stopped Music Player Daemon. Mar 08 11:34:37 volumio systemd[1]: Starting Music Player Daemon... Mar 08 11:34:37 volumio volumio[1062]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 11:34:37 volumio volumio[1062]: info: [1741401277741] CoreMusicLibrary::Adding element Last_100 Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 11:34:37 volumio volumio[1062]: info: [1741401277751] CoreMusicLibrary::Adding element Webradio Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 11:34:37 volumio volumio[1062]: info: Initializing BBC Radios Mar 08 11:34:37 volumio sudo[1264]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 08 11:34:37 volumio sudo[1264]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:37 volumio sudo[1264]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:34:37 volumio volumio[1062]: info: Volumio Calling Home Mar 08 11:34:37 volumio volumio[1062]: info: Discovery: adding e100114a-51cf-4408-9908-0fe0e69ae1ee Mar 08 11:34:37 volumio volumio[1062]: info: Discovery: Found device Volumio Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:37 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:37 volumio volumio[1062]: info: MPD Permissions set Mar 08 11:34:37 volumio volumio[1062]: info: MPD Permissions set Mar 08 11:34:37 volumio volumio[1062]: info: VolumeController:: Volume=100 Mute =false Mar 08 11:34:37 volumio volumio[1062]: info: CoreStateMachine::pushState Mar 08 11:34:37 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:37 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 11:34:38 volumio volumio[1062]: info: Discovery: Getting this device information Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:38 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 11:34:38 volumio volumio[1062]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:34:38 volumio volumio[1062]: info: Starting Shairport Sync Mar 08 11:34:38 volumio volumio[1062]: info: Starting Shairport Sync Mar 08 11:34:38 volumio volumio[1062]: info: Starting Shairport Sync Mar 08 11:34:38 volumio sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 08 11:34:38 volumio sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:38 volumio sudo[1307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 08 11:34:38 volumio sudo[1307]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:38 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:38 volumio sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 08 11:34:38 volumio sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 08 11:34:38 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 08 11:34:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 08 11:34:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 08 11:34:38 volumio sudo[1307]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:38 volumio volumio[1062]: info: Shairport-Sync Started Mar 08 11:34:38 volumio sudo[1305]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:38 volumio volumio[1062]: Error adding Membership: Error: addMembership EINVAL Mar 08 11:34:38 volumio volumio[1062]: info: Shairport-Sync Started Mar 08 11:34:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 08 11:34:38 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 08 11:34:38 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 08 11:34:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 08 11:34:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 08 11:34:38 volumio sudo[1311]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:38 volumio volumio[1062]: verbose: New Socket.io Connection to 192.168.2.126:3000 from 192.168.2.135 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Mar 08 11:34:38 volumio volumio[1062]: info: Shairport-Sync Started Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:38 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 08 11:34:38 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 08 11:34:38 volumio mpd[1288]: Mar 08 11:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 08 11:34:38 volumio systemd[1]: Started Music Player Daemon. Mar 08 11:34:38 volumio sudo[1246]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:38 volumio sudo[1237]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:38 volumio volumio[1062]: info: Completed starting Core Plugins Mar 08 11:34:38 volumio volumio[1062]: info: ------------------------------------------- Mar 08 11:34:38 volumio volumio[1062]: info: ----- MyVolumio plugins startup ---- Mar 08 11:34:38 volumio volumio[1062]: info: ------------------------------------------- Mar 08 11:34:38 volumio volumio[1062]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 08 11:34:38 volumio volumio[1062]: error: MPD error: The expression evaluated to a falsy value: Mar 08 11:34:38 volumio volumio[1062]: assert.ok(self.idling) Mar 08 11:34:38 volumio volumio[1062]: error: The expression evaluated to a falsy value: Mar 08 11:34:38 volumio volumio[1062]: assert.ok(self.idling) Mar 08 11:34:38 volumio volumio[1062]: info: MPD running with PID1288 Mar 08 11:34:38 volumio volumio[1062]: ,establishing connection Mar 08 11:34:38 volumio volumio[1062]: error: updateQueue error: null Mar 08 11:34:38 volumio volumio[1062]: error: updateQueue error: null Mar 08 11:34:38 volumio sudo[1120]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:38 volumio volumio[1062]: info: Volumio called home Mar 08 11:34:40 volumio volumio[1062]: verbose: New Socket.io Connection to 192.168.2.126 from 192.168.2.135 UA: Mozilla/5.0 (Linux; Android 12; moto g52j 5G Build/S3RYBS32.168-19-5-17; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::volumioGetVisibleSources Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:40 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::volumioGetQueue Mar 08 11:34:40 volumio volumio[1062]: info: CoreStateMachine::getQueue Mar 08 11:34:40 volumio volumio[1062]: info: CorePlayQueue::getQueue Mar 08 11:34:40 volumio volumio[1062]: info: Listing playlists Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 08 11:34:40 volumio volumio[1062]: info: Received Get System Info Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 11:34:40 volumio volumio[1062]: info: Discovery: Getting this device information Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:40 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 11:34:40 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:40 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:41 volumio systemd[1]: systemd-fsckd.service: Succeeded. Mar 08 11:34:42 volumio sh[537]: timed out Mar 08 11:34:42 volumio dhcpcd[573]: timed out Mar 08 11:34:42 volumio sh[537]: dhcpcd exited Mar 08 11:34:42 volumio dhcpcd[573]: dhcpcd exited Mar 08 11:34:42 volumio sh[537]: ifup: failed to bring up eth0 Mar 08 11:34:42 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 08 11:34:42 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 08 11:34:43 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Mar 08 11:34:43 volumio volumio[1062]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 08 11:34:45 volumio sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 08 11:34:45 volumio sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:45 volumio sudo[1341]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:45 volumio sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 11:34:45 volumio sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:45 volumio sudo[1343]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:45 volumio sudo[1347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 08 11:34:45 volumio sudo[1347]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:45 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 08 11:34:45 volumio sudo[1347]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:45 volumio volumio[1062]: info: Upmpdcli Daemon Started Mar 08 11:34:45 volumio volumio[1349]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 08 11:34:47 volumio volumio[1062]: info: Adding plugin bluetooth to MyMusic Plugins Mar 08 11:34:47 volumio volumio[1062]: info: Adding plugin multiroom to MyMusic Plugins Mar 08 11:34:47 volumio volumio[1062]: info: Adding plugin metavolumio to MyMusic Plugins Mar 08 11:34:47 volumio volumio[1062]: info: Adding plugin cd_controller to MyMusic Plugins Mar 08 11:34:47 volumio volumio[1062]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 08 11:34:47 volumio volumio[1062]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 08 11:34:47 volumio volumio[1062]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 08 11:34:48 volumio volumio[1062]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 08 11:34:48 volumio volumio[1062]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 08 11:34:48 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:34:48 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:34:48 volumio volumio[1062]: info: Starting MyVolumio Remote Streaming Endpoints Mar 08 11:34:48 volumio volumio[1062]: info: MyVolumio not started Mar 08 11:34:48 volumio volumio[1062]: info: Initializing device activation check Mar 08 11:34:48 volumio volumio[1062]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 08 11:34:48 volumio volumio[1062]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 08 11:34:49 volumio volumio[1062]: info: Starting Streaming Service Transparent Proxy Mar 08 11:34:49 volumio volumio[1062]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 08 11:34:49 volumio volumio[1062]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 08 11:34:49 volumio volumio[1062]: info: Streaming services startup Mar 08 11:34:49 volumio volumio[1062]: info: Starting Streaming Daemon Mar 08 11:34:49 volumio sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 08 11:34:49 volumio sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:49 volumio sudo[1372]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:49 volumio volumio[1062]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 08 11:34:49 volumio volumio[1062]: error: Cannot start Volumio Streaming Daemon Mar 08 11:34:49 volumio volumio[1062]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 08 11:34:49 volumio volumio[1062]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 08 11:34:49 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 11:34:49 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 11:34:49 volumio volumio[1062]: info: Discovery: Getting this device information Mar 08 11:34:49 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:49 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:49 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 11:34:49 volumio volumio[1062]: STREAMING PROXY: Starting server on port 3245 Mar 08 11:34:49 volumio volumio[1062]: Node JS runtime: 14 Mar 08 11:34:50 volumio volumio[1349]: ........................................................++++ Mar 08 11:34:56 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 11:34:56 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 11:34:56 volumio volumio[1062]: info: Discovery: Getting this device information Mar 08 11:34:56 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:56 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:56 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 11:34:56 volumio volumio[1062]: verbose: New Socket.io Connection to 192.168.2.126:3000 from 192.168.2.135 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Mar 08 11:34:56 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:34:56 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:34:56 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 08 11:34:56 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 08 11:34:58 volumio volumio[1349]: ...............................................................................++++ Mar 08 11:34:58 volumio volumio[1349]: e is 65537 (0x010001) Mar 08 11:34:58 volumio volumio[1349]: writing RSA key Mar 08 11:34:59 volumio sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 08 11:34:59 volumio sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:59 volumio sudo[1412]: pam_unix(sudo:session): session closed for user root Mar 08 11:34:59 volumio sudo[1414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 11:34:59 volumio sudo[1414]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:34:59 volumio sudo[1414]: pam_unix(sudo:session): session closed for user root Mar 08 11:35:00 volumio volumio[1062]: verbose: New Socket.io Connection to 192.168.2.126 from 192.168.2.135 UA: Mozilla/5.0 (Linux; Android 12; moto g52j 5G Build/S3RYBS32.168-19-5-17; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 08 11:35:00 volumio sudo[1418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 08 11:35:00 volumio sudo[1418]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:35:00 volumio sudo[1418]: pam_unix(sudo:session): session closed for user root Mar 08 11:35:00 volumio sudo[1420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 11:35:00 volumio sudo[1420]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:35:00 volumio sudo[1420]: pam_unix(sudo:session): session closed for user root Mar 08 11:35:00 volumio volumio[1062]: verbose: New Socket.io Connection to 192.168.2.126 from 192.168.2.135 UA: Mozilla/5.0 (Linux; Android 12; moto g52j 5G Build/S3RYBS32.168-19-5-17; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.137 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::volumioGetVisibleSources Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:35:00 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 08 11:35:00 volumio volumio[1062]: info: Received Get System Info Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 11:35:00 volumio volumio[1062]: info: Discovery: Getting this device information Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:35:00 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:35:00 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:35:00 volumio volumio[1062]: info: Listing playlists Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 08 11:35:00 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 08 11:35:02 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 08 11:35:02 volumio volumio[1062]: info: Received Get System Info Mar 08 11:35:02 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 11:35:02 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 11:35:02 volumio volumio[1062]: info: Discovery: Getting this device information Mar 08 11:35:02 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:35:02 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:35:02 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 11:35:02 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 08 11:35:03 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 08 11:35:03 volumio volumio[1062]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 08 11:35:03 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:35:03 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:35:03 volumio volumio[1062]: info: CoreCommandRouter::volumioPlay Mar 08 11:35:03 volumio volumio[1062]: info: CoreStateMachine::play index undefined Mar 08 11:35:03 volumio volumio[1062]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 11:35:03 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:35:03 volumio volumio[1062]: info: CoreStateMachine::startPlaybackTimer Mar 08 11:35:03 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:35:03 volumio volumio[1062]: verbose: ControllerMpd::clearAddPlayTracks NAS/disk1/Fusion Orchestra/Skeleton In Armour/01 Fanfairy Suite For 1000 Trampits (Part One).flac Mar 08 11:35:03 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 11:35:03 volumio volumio[1062]: info: sendMpdCommand stop took 1 milliseconds Mar 08 11:35:03 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 11:35:03 volumio volumio[1062]: info: sendMpdCommand clear took 0 milliseconds Mar 08 11:35:03 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand add "NAS/disk1/Fusion Orchestra/Skeleton In Armour/01 Fanfairy Suite For 1000 Trampits (Part One).flac" Mar 08 11:35:03 volumio volumio[1062]: info: Mar 08 11:35:03 volumio volumio[1062]: ---------------------------- MPD announces system playlist update Mar 08 11:35:03 volumio volumio[1062]: info: Ignoring MPD Status Update Mar 08 11:35:03 volumio volumio[1062]: info: Mar 08 11:35:03 volumio volumio[1062]: ---------------------------- MPD announces system playlist update Mar 08 11:35:03 volumio volumio[1062]: info: Ignoring MPD Status Update Mar 08 11:35:03 volumio volumio[1062]: info: Mar 08 11:35:03 volumio volumio[1062]: ---------------------------- MPD announces system playlist update Mar 08 11:35:03 volumio volumio[1062]: info: Ignoring MPD Status Update Mar 08 11:35:03 volumio volumio[1062]: error: updateQueue error: null Mar 08 11:35:03 volumio volumio[1062]: error: updateQueue error: null Mar 08 11:35:03 volumio volumio[1062]: error: updateQueue error: null Mar 08 11:35:03 volumio volumio[1062]: info: ------------------------------ 4ms Mar 08 11:35:03 volumio volumio[1062]: info: ------------------------------ 3ms Mar 08 11:35:03 volumio volumio[1062]: info: ------------------------------ 2ms Mar 08 11:35:04 volumio systemd[1]: systemd-timedated.service: Succeeded. Mar 08 11:35:07 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 11:35:07 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:35:07 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 08 11:35:08 volumio volumio-remote-updater[624]: No test mode Mar 08 11:35:08 volumio volumio-remote-updater[624]: No alpha test mode Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 11:35:08 volumio volumio[1062]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 08 11:35:08 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 08 11:35:09 volumio volumio[1062]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 08 11:35:09 volumio volumio[1062]: info: Completed starting MyVolumio Plugin Mar 08 11:35:09 volumio volumio[1062]: [Metrics] CommandRouter: 35s 810.92ms Mar 08 11:35:09 volumio volumio[1062]: info: CoreCommandRouter::volumiosetStartupVolume Mar 08 11:35:09 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 11:35:09 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 11:35:09 volumio volumio[1062]: info: CoreCommandRouter::Close All Modals sent Mar 08 11:35:09 volumio volumio[1062]: info: CoreCommandRouter::Close All Modals sent Mar 08 11:35:09 volumio volumio[1062]: info: CoreCommandRouter::volumioGetQueue Mar 08 11:35:09 volumio volumio[1062]: info: CoreStateMachine::getQueue Mar 08 11:35:09 volumio volumio[1062]: info: CorePlayQueue::getQueue Mar 08 11:35:10 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 08 11:35:10 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 08 11:35:10 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 08 11:35:10 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 08 11:35:14 volumio volumio[1062]: info: CorePlayQueue::getTrack 0 Mar 08 11:35:14 volumio volumio[1062]: info: CorePlayQueue::getTrack 1 Mar 08 11:35:14 volumio volumio[1062]: info: Prefetching next song Mar 08 11:35:14 volumio volumio[1062]: info: DOING PREFETCH IN MPD Mar 08 11:35:14 volumio volumio[1062]: verbose: ControllerMpd::sendMpdCommand add "NAS/disk1/Fusion Orchestra/Skeleton In Armour/02 Sonata In Z.flac" Mar 08 11:35:16 volumio volumio[1062]: info: BOOT COMPLETED Mar 08 11:35:18 volumio ntpd[814]: Soliciting pool server 160.16.113.133 Mar 08 11:35:18 volumio volumio[1062]: info: CoreStateMachine::startPlaybackTimer Mar 08 11:35:18 volumio volumio[1062]: info: CorePlayQueue::getTrack 1 Mar 08 11:35:19 volumio volumio[1062]: info: CoreStateMachine::pushState Mar 08 11:35:19 volumio volumio[1062]: info: CorePlayQueue::getTrack 1 Mar 08 11:35:19 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 11:35:19 volumio volumio[1062]: info: CoreCommandRouter::volumioPushState Mar 08 11:35:19 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 08 11:35:19 volumio volumio[1062]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 08 11:35:19 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 08 11:35:19 volumio volumio[1062]: info: Received Get System Version Mar 08 11:35:19 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 11:35:19 volumio volumio[1062]: info: Received Get System Info Mar 08 11:35:19 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 11:35:19 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 11:35:19 volumio volumio[1062]: info: Discovery: Getting this device information Mar 08 11:35:19 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:35:19 volumio volumio[1062]: info: CorePlayQueue::getTrack 1 Mar 08 11:35:19 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 11:35:19 volumio ntpd[814]: Soliciting pool server 172.105.240.243 Mar 08 11:35:19 volumio ntpd[814]: Soliciting pool server 202.181.103.212 Mar 08 11:35:20 volumio ntpd[814]: Soliciting pool server 129.250.35.250 Mar 08 11:35:20 volumio ntpd[814]: Soliciting pool server 45.76.211.39 Mar 08 11:35:21 volumio ntpd[814]: Soliciting pool server 45.77.20.103 Mar 08 11:35:21 volumio ntpd[814]: Soliciting pool server 122.215.240.52 Mar 08 11:35:21 volumio ntpd[814]: Soliciting pool server 162.159.200.1 Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 11:35:22 volumio volumio[1062]: info: Retrieving Cloud Streaming UI Mar 08 11:35:22 volumio volumio[1062]: info: Getting Tidal Cloud Configuration Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 11:35:22 volumio volumio[1062]: info: Getting Qobuz Cloud Configuration Mar 08 11:35:22 volumio volumio[1062]: info: Asking plugin for UI Config Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 11:35:22 volumio volumio[1062]: info: Getting Spotify Cloud Configuration Mar 08 11:35:22 volumio volumio[1062]: info: Asking plugin for UI Config Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 11:35:22 volumio volumio[1062]: info: Saving Spotify Acccount Mar 08 11:35:22 volumio volumio[1062]: info: Got Tidal Cloud Configuration Mar 08 11:35:22 volumio volumio[1062]: info: Got it Mar 08 11:35:22 volumio volumio[1062]: info: Got it Mar 08 11:35:22 volumio volumio[1062]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 11:35:22 volumio volumio[1062]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::volumioGetBrowseSources Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 08 11:35:22 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 08 11:35:22 volumio ntpd[814]: Soliciting pool server 129.250.35.251 Mar 08 11:35:22 volumio ntpd[814]: Soliciting pool server 133.243.238.243 Mar 08 11:35:23 volumio ntpd[814]: Soliciting pool server 133.243.238.163 Mar 08 11:35:23 volumio ntpd[814]: Soliciting pool server 23.81.40.154 Mar 08 11:35:24 volumio ntpd[814]: Soliciting pool server 162.159.200.123 Mar 08 11:35:24 volumio ntpd[814]: Soliciting pool server 2001:418:3ff::53 Mar 08 11:35:25 volumio ntpd[814]: Soliciting pool server 108.160.132.224 Mar 08 11:35:26 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 08 11:35:27 volumio ntpd[814]: receive: Unexpected origin timestamp 0xeb762b6e.9d464ace does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xeb762b6f.3f24b5be Mar 08 11:35:27 volumio ntpd[814]: receive: Unexpected origin timestamp 0xeb762b6e.9d471c55 does not match aorg 0000000000.00000000 from server@45.76.211.39 xmt 0xeb762b6f.3f7ece94 Mar 08 11:35:27 volumio ntpd[814]: receive: Unexpected origin timestamp 0xeb762b6e.9d47e545 does not match aorg 0000000000.00000000 from server@172.105.240.243 xmt 0xeb762b6f.3f69b274 Mar 08 11:35:27 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 11:35:27 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 11:35:27 volumio volumio[1062]: info: Discovery: Getting this device information Mar 08 11:35:27 volumio volumio[1062]: info: CoreCommandRouter::volumioGetState Mar 08 11:35:27 volumio volumio[1062]: info: CorePlayQueue::getTrack 1 Mar 08 11:35:27 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 11:35:28 volumio volumio[1062]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Mar 08 11:35:28 volumio sudo[1522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/disk1 Mar 08 11:35:28 volumio sudo[1522]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 11:35:28 volumio sudo[1522]: pam_unix(sudo:session): session closed for user root Mar 08 11:35:28 volumio volumio[1062]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 11:35:28 volumio volumio[1062]: Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/disk1' Mar 08 11:35:28 volumio volumio[1062]: at Object.rmdirSync (fs.js:890:10) Mar 08 11:35:28 volumio volumio[1062]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12 Mar 08 11:35:28 volumio volumio[1062]: at ChildProcess.exithandler (child_process.js:299:7) Mar 08 11:35:28 volumio volumio[1062]: at ChildProcess.emit (events.js:315:20) Mar 08 11:35:28 volumio volumio[1062]: at maybeClose (internal/child_process.js:1048:16) Mar 08 11:35:28 volumio volumio[1062]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5) { Mar 08 11:35:28 volumio volumio[1062]: errno: -16, Mar 08 11:35:28 volumio volumio[1062]: syscall: 'rmdir', Mar 08 11:35:28 volumio volumio[1062]: code: 'EBUSY', Mar 08 11:35:28 volumio volumio[1062]: path: '/mnt/NAS/disk1' Mar 08 11:35:28 volumio volumio[1062]: } Mar 08 11:35:28 volumio volumio[1062]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 11:35:29 volumio sudo[1534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-08 11:34 Mar 08 11:35:29 volumio sudo[1534]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"