-- Logs begin at Thu 2025-03-20 15:08:38 JST, end at Thu 2025-03-20 15:11:53 JST. -- Mar 20 15:10:19 volumio2 systemd-timedated[917]: Changed local time to Thu Mar 20 15:10:19 2025 Mar 20 15:10:19 volumio2 sudo[911]: pam_unix(sudo:session): session closed for user root Mar 20 15:10:19 volumio2 volumio-time-update[421]: volumio-time-update-util: System time updated successfully. Mar 20 15:10:19 volumio2 systemd[1]: Started Volumio Time Update Utility. Mar 20 15:10:21 volumio2 winbindd[909]: [2025/03/20 15:10:21.535737, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 20 15:10:21 volumio2 winbindd[909]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 20 15:10:21 volumio2 systemd[1]: Started Samba Winbind Daemon. Mar 20 15:10:21 volumio2 winbindd[909]: [2025/03/20 15:10:21.691622, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 20 15:10:21 volumio2 winbindd[909]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 20 15:10:21 volumio2 systemd[1]: Starting Samba SMB Daemon... Mar 20 15:10:23 volumio2 wireless.js[405]: WIRELESS: No wireless interface, exiting Mar 20 15:10:23 volumio2 iw[932]: command failed: No such device (-19) Mar 20 15:10:24 volumio2 iwconfig[935]: Error for wireless request "Set Power Management" (8B2C) : Mar 20 15:10:24 volumio2 iwconfig[935]: SET failed on device wlan0 ; No such device. Mar 20 15:10:24 volumio2 systemd[1]: wireless.service: Succeeded. Mar 20 15:10:24 volumio2 systemd[1]: Started Wireless Services. Mar 20 15:10:24 volumio2 systemd[1]: Started Volumio Backend Module. Mar 20 15:10:24 volumio2 systemd[1]: Started Volumio Cpu Tweaker. Mar 20 15:10:25 volumio2 volumio-cpu-tweak[939]: Setting RT Priority for mpd Mar 20 15:10:26 volumio2 volumio-cpu-tweak[939]: Not enough cores to set MPD affinity Mar 20 15:10:26 volumio2 kernel: sched: RT throttling activated Mar 20 15:10:27 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:27] [info] asio async_connect error: system:111 (Connection refused) Mar 20 15:10:27 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:27] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 20 15:10:27 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:27] [error] handle_connect error: Underlying Transport Error Mar 20 15:10:28 volumio2 volumio-cpu-tweak[939]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 20 15:10:28 volumio2 volumio-cpu-tweak[939]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 20 15:10:31 volumio2 systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 20 15:10:34 volumio2 mpd[632]: Mar 20 15:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 20 15:10:35 volumio2 systemd[1]: Started Music Player Daemon. Mar 20 15:10:35 volumio2 mpd_monitor.sh[433]: MPD restarted due to no mpc output. Mar 20 15:10:37 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:37] [info] asio async_connect error: system:111 (Connection refused) Mar 20 15:10:37 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:37] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 20 15:10:37 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:37] [error] handle_connect error: Underlying Transport Error Mar 20 15:10:38 volumio2 smbd[927]: [2025/03/20 15:10:38.691681, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 20 15:10:38 volumio2 smbd[927]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 20 15:10:38 volumio2 systemd[1]: Started Samba SMB Daemon. Mar 20 15:10:38 volumio2 systemd[1]: Reached target Multi-User System. Mar 20 15:10:38 volumio2 systemd[1]: Reached target Graphical Interface. Mar 20 15:10:38 volumio2 systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 20 15:10:39 volumio2 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 20 15:10:39 volumio2 systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 20 15:10:39 volumio2 systemd[1]: Startup finished in 27.488s (kernel) + 1min 29.393s (userspace) = 1min 56.881s. Mar 20 15:10:47 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:47] [info] asio async_connect error: system:111 (Connection refused) Mar 20 15:10:47 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 20 15:10:47 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:47] [error] handle_connect error: Underlying Transport Error Mar 20 15:10:49 volumio2 systemd[1]: systemd-timedated.service: Succeeded. Mar 20 15:10:53 volumio2 volumio[938]: info: ------------------------------------------- Mar 20 15:10:53 volumio2 volumio[938]: info: ----- Volumio3 ---- Mar 20 15:10:53 volumio2 volumio[938]: info: ------------------------------------------- Mar 20 15:10:53 volumio2 volumio[938]: info: ----- System startup ---- Mar 20 15:10:53 volumio2 volumio[938]: info: ------------------------------------------- Mar 20 15:10:57 volumio2 volumio-remote-updater[439]: [2025-03-20 15:10:57] [connect] Successful connection Mar 20 15:10:59 volumio2 volumio[938]: info: MYVOLUMIO Environment detected Mar 20 15:11:00 volumio2 volumio[938]: info: Plugin folders cleanup Mar 20 15:11:00 volumio2 volumio[938]: info: Scanning into folder /volumio/app/plugins/ Mar 20 15:11:00 volumio2 volumio[938]: info: Scanning category audio_interface Mar 20 15:11:00 volumio2 volumio[938]: info: Scanning category miscellanea Mar 20 15:11:00 volumio2 volumio[938]: info: Scanning category music_service Mar 20 15:11:00 volumio2 volumio[938]: info: Scanning category plugins.json Mar 20 15:11:00 volumio2 volumio[938]: info: Scanning category system_controller Mar 20 15:11:00 volumio2 volumio[938]: info: Scanning category user_interface Mar 20 15:11:00 volumio2 volumio[938]: info: Scanning into folder /data/plugins/ Mar 20 15:11:00 volumio2 volumio[938]: info: Plugin folders cleanup completed Mar 20 15:11:00 volumio2 volumio[938]: info: ------------------------------------------- Mar 20 15:11:00 volumio2 volumio[938]: info: ----- Core plugins startup ---- Mar 20 15:11:00 volumio2 volumio[938]: info: ------------------------------------------- Mar 20 15:11:00 volumio2 volumio[938]: info: Loading plugins from folder /volumio/app/plugins/ Mar 20 15:11:00 volumio2 volumio[938]: info: Adding plugin upnp to MyMusic Plugins Mar 20 15:11:00 volumio2 volumio[938]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 20 15:11:00 volumio2 volumio[938]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 20 15:11:00 volumio2 volumio[938]: info: Loading plugins from folder /data/plugins/ Mar 20 15:11:00 volumio2 volumio[938]: info: Loading plugin "system"... Mar 20 15:11:00 volumio2 volumio[938]: info: Loading plugin "appearance"... Mar 20 15:11:07 volumio2 ntpd[575]: Soliciting pool server 162.159.200.123 Mar 20 15:11:08 volumio2 volumio[938]: info: Loading plugin "network"... Mar 20 15:11:08 volumio2 volumio[938]: info: Refreshing Cached IP Addresses Mar 20 15:11:08 volumio2 ntpd[575]: Soliciting pool server 47.79.37.210 Mar 20 15:11:08 volumio2 ntpd[575]: Soliciting pool server 167.179.119.205 Mar 20 15:11:08 volumio2 sudo[1041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 20 15:11:08 volumio2 sudo[1041]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:11:08 volumio2 sudo[1043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 20 15:11:08 volumio2 sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:11:08 volumio2 volumio[938]: info: Loading plugin "services"... Mar 20 15:11:08 volumio2 sudo[1041]: pam_unix(sudo:session): session closed for user root Mar 20 15:11:09 volumio2 sudo[1043]: pam_unix(sudo:session): session closed for user root Mar 20 15:11:09 volumio2 volumio[938]: info: Loading plugin "alsa_controller"... Mar 20 15:11:09 volumio2 sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 20 15:11:09 volumio2 sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:11:09 volumio2 ntpd[575]: Soliciting pool server 133.130.121.141 Mar 20 15:11:09 volumio2 ntpd[575]: Soliciting pool server 45.76.211.39 Mar 20 15:11:09 volumio2 ntpd[575]: Soliciting pool server 162.159.200.1 Mar 20 15:11:10 volumio2 sudo[1050]: pam_unix(sudo:session): session closed for user root Mar 20 15:11:10 volumio2 ntpd[575]: Soliciting pool server 122.215.240.52 Mar 20 15:11:10 volumio2 ntpd[575]: Soliciting pool server 129.250.35.250 Mar 20 15:11:10 volumio2 ntpd[575]: Soliciting pool server 45.77.20.103 Mar 20 15:11:10 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 20 15:11:10 volumio2 volumio[938]: info: Loading plugin "wizard"... Mar 20 15:11:10 volumio2 volumio[938]: info: Loading plugin "networkfs"... Mar 20 15:11:11 volumio2 volumio[938]: info: Starting Udev Watcher for removable devices Mar 20 15:11:11 volumio2 sudo[1077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=volumio,password=volumio,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.30/USB /mnt/NAS/USB Mar 20 15:11:11 volumio2 sudo[1077]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:11:11 volumio2 volumio[938]: info: Ignoring mount for partition: boot Mar 20 15:11:11 volumio2 volumio[938]: info: Ignoring mount for partition: volumio Mar 20 15:11:11 volumio2 volumio[938]: info: Ignoring mount for partition: volumio_data Mar 20 15:11:11 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 20 15:11:11 volumio2 volumio[938]: info: Loading plugin "volumio_command_line_client"... Mar 20 15:11:11 volumio2 ntpd[575]: Soliciting pool server 118.156.189.22 Mar 20 15:11:11 volumio2 ntpd[575]: Soliciting pool server 45.159.48.231 Mar 20 15:11:11 volumio2 volumio[938]: info: Loading plugin "upnp"... Mar 20 15:11:11 volumio2 ntpd[575]: Soliciting pool server 139.162.81.45 Mar 20 15:11:11 volumio2 volumio[938]: info: [1742451071655] Starting Upmpd Daemon Mar 20 15:11:11 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 20 15:11:11 volumio2 volumio[938]: info: Loading plugin "my_music"... Mar 20 15:11:11 volumio2 volumio[938]: info: Loading plugin "mpd"... Mar 20 15:11:12 volumio2 volumio-remote-updater[439]: [2025-03-20 15:11:12] [connect] Successful connection Mar 20 15:11:12 volumio2 kernel: Key type cifs.spnego registered Mar 20 15:11:12 volumio2 kernel: Key type cifs.idmap registered Mar 20 15:11:12 volumio2 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 20 15:11:12 volumio2 kernel: CIFS: Attempting to mount //192.168.0.30/USB Mar 20 15:11:12 volumio2 ntpd[575]: Soliciting pool server 45.76.218.37 Mar 20 15:11:12 volumio2 ntpd[575]: Soliciting pool server 129.250.35.251 Mar 20 15:11:12 volumio2 ntpd[575]: Soliciting pool server 172.105.240.243 Mar 20 15:11:13 volumio2 ntpd[575]: Soliciting pool server 23.81.40.154 Mar 20 15:11:13 volumio2 ntpd[575]: Soliciting pool server 2406:da14:10c4:9aa0:123:: Mar 20 15:11:14 volumio2 sudo[1077]: pam_unix(sudo:session): session closed for user root Mar 20 15:11:14 volumio2 ntpd[575]: Soliciting pool server 108.160.132.224 Mar 20 15:11:21 volumio2 ntpd[575]: receive: Unexpected origin timestamp 0xeb863003.8c88a49a does not match aorg 0000000000.00000000 from server@45.77.20.103 xmt 0xeb863009.e90226d2 Mar 20 15:11:21 volumio2 ntpd[575]: receive: Unexpected origin timestamp 0xeb863003.8c638f66 does not match aorg 0000000000.00000000 from server@139.162.81.45 xmt 0xeb863009.e8be2fc4 Mar 20 15:11:21 volumio2 ntpd[575]: receive: Unexpected origin timestamp 0xeb863003.8ca85759 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xeb863009.e9db4b72 Mar 20 15:11:21 volumio2 ntpd[575]: receive: Unexpected origin timestamp 0xeb863003.8c77be06 does not match aorg 0000000000.00000000 from server@118.156.189.22 xmt 0xeb863009.e97263c9 Mar 20 15:11:21 volumio2 ntpd[575]: receive: Unexpected origin timestamp 0xeb863003.8c48bcbf does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xeb863009.ea32eead Mar 20 15:11:22 volumio2 volumio[938]: info: Loading plugin "upnp_browser"... Mar 20 15:11:25 volumio2 volumio[938]: info: Loading plugin "alarm-clock"... Mar 20 15:11:26 volumio2 volumio[938]: info: Loading plugin "airplay_emulation"... Mar 20 15:11:26 volumio2 volumio[938]: info: Starting Shairport Sync Mar 20 15:11:26 volumio2 volumio[938]: info: Loading plugin "last_100"... Mar 20 15:11:26 volumio2 volumio[938]: info: Loading plugin "webradio"... Mar 20 15:11:27 volumio2 volumio[938]: info: Loading plugin "i2s_dacs"... Mar 20 15:11:27 volumio2 volumio[938]: info: I2S DAC not set, start Auto-detection Mar 20 15:11:27 volumio2 volumio[938]: info: Loading plugin "volumiodiscovery"... Mar 20 15:11:27 volumio2 volumio[938]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 20 15:11:27 volumio2 volumio[938]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 20 15:11:27 volumio2 volumio[938]: *** WARNING *** For more information see Mar 20 15:11:27 volumio2 volumio[938]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 20 15:11:27 volumio2 volumio[938]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 20 15:11:27 volumio2 volumio[938]: *** WARNING *** For more information see Mar 20 15:11:27 volumio2 node[938]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 20 15:11:27 volumio2 node[938]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 20 15:11:27 volumio2 node[938]: *** WARNING *** For more information see Mar 20 15:11:27 volumio2 node[938]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 20 15:11:27 volumio2 node[938]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 20 15:11:27 volumio2 node[938]: *** WARNING *** For more information see Mar 20 15:11:27 volumio2 volumio[938]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 20 15:11:27 volumio2 volumio[938]: info: Discovery: Started advertising with name: Volumio2 Mar 20 15:11:28 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 20 15:11:28 volumio2 volumio[938]: info: Loading plugin "outputs"... Mar 20 15:11:28 volumio2 volumio[938]: info: Loading plugin "albumart"... Mar 20 15:11:28 volumio2 volumio[938]: info: Plugin example_plugin is not enabled Mar 20 15:11:28 volumio2 volumio[938]: info: Loading plugin "inputs"... Mar 20 15:11:28 volumio2 volumio[938]: info: Loading plugin "updater_comm"... Mar 20 15:11:31 volumio2 volumio[938]: info: Plugin mpdemulation is not enabled Mar 20 15:11:31 volumio2 volumio[938]: info: Loading plugin "rest_api"... Mar 20 15:11:31 volumio2 volumio[938]: info: Loading plugin "websocket"... Mar 20 15:11:32 volumio2 volumio[938]: info: Starting Socket.io Server version 2.3.0 Mar 20 15:11:32 volumio2 volumio[938]: info: Loading i18n strings for locale ja Mar 20 15:11:32 volumio2 volumio[938]: Forking 1 albumart workers Mar 20 15:11:32 volumio2 volumio[938]: Updating browse sources language Mar 20 15:11:32 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 20 15:11:33 volumio2 volumio-remote-updater[439]: [2025-03-20 15:11:33] [connect] Successful connection Mar 20 15:11:35 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:11:35 volumio2 volumio[938]: info: CoreCommandRouter::initPlayerControls Mar 20 15:11:35 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 20 15:11:35 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 20 15:11:35 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 20 15:11:35 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 20 15:11:35 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 20 15:11:35 volumio2 volumio[938]: Express server listening on port 3000 Mar 20 15:11:35 volumio2 volumio[938]: [Metrics] WebUI: 41s 677.66ms Mar 20 15:11:36 volumio2 volumio[938]: info: CoreStateMachine::resetVolumioState Mar 20 15:11:36 volumio2 volumio[938]: info: CoreStateMachine::getcurrentVolume Mar 20 15:11:36 volumio2 volumio[938]: info: CoreCommandRouter::volumioRetrievevolume Mar 20 15:11:36 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 20 15:11:37 volumio2 sudo[1170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 20 15:11:37 volumio2 sudo[1170]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:11:37 volumio2 sudo[1176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 20 15:11:37 volumio2 sudo[1176]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:11:37 volumio2 sudo[1170]: pam_unix(sudo:session): session closed for user root Mar 20 15:11:37 volumio2 sudo[1176]: pam_unix(sudo:session): session closed for user root Mar 20 15:11:38 volumio2 volumio[938]: info: Volumio Network Manager: Network status updated: 1 Mar 20 15:11:38 volumio2 volumio[938]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Mar 20 15:11:38 volumio2 volumio[938]: wlan0 Interface doesn't support scanning. Mar 20 15:11:38 volumio2 volumio[938]: info: Cannot use regular scanning, forcing with ap-force Mar 20 15:11:38 volumio2 sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Mar 20 15:11:38 volumio2 sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:11:38 volumio2 sudo[1183]: pam_unix(sudo:session): session closed for user root Mar 20 15:11:38 volumio2 volumio[938]: command failed: No such device (-19) Mar 20 15:11:38 volumio2 volumio[938]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Mar 20 15:11:38 volumio2 volumio[938]: command failed: No such device (-19) Mar 20 15:11:40 volumio2 volumio[938]: verbose: New Socket.io Connection to 192.168.0.32:3000 from 192.168.0.30 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Mar 20 15:11:40 volumio2 volumio[938]: verbose: New Socket.io Connection to 192.168.0.32:3000 from 192.168.0.30 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 20 15:11:41 volumio2 volumio[938]: info: Mar 20 15:11:41 volumio2 volumio[938]: ---------------------------- Client requests Volume 80 Mar 20 15:11:41 volumio2 volumio[938]: info: VolumeController::SetAlsaVolume80 Mar 20 15:11:41 volumio2 volumio[938]: info: CoreStateMachine::pushState Mar 20 15:11:41 volumio2 volumio[938]: info: CorePlayQueue::getTrack 0 Mar 20 15:11:41 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 20 15:11:41 volumio2 volumio[938]: info: CoreCommandRouter::volumioPushState Mar 20 15:11:42 volumio2 volumio[938]: info: Reloading queue from file Mar 20 15:11:42 volumio2 volumio[938]: info: VolumeController:: Volume=80 Mute =false Mar 20 15:11:42 volumio2 volumio[938]: info: CoreStateMachine::pushState Mar 20 15:11:42 volumio2 volumio[938]: info: CorePlayQueue::getTrack 0 Mar 20 15:11:42 volumio2 volumio[938]: info: CoreCommandRouter::volumioPushState Mar 20 15:11:42 volumio2 volumio[938]: info: CoreStateMachine::updateTrackBlock Mar 20 15:11:42 volumio2 volumio[938]: info: CorePlayQueue::getTrackBlock Mar 20 15:11:42 volumio2 volumio[938]: info: CoreCommandRouter::volumioRetrievevolume Mar 20 15:11:43 volumio2 volumio[938]: info: CoreStateMachine::setRepeat null single undefined Mar 20 15:11:43 volumio2 volumio[938]: info: CoreStateMachine::pushState Mar 20 15:11:43 volumio2 volumio[938]: info: CorePlayQueue::getTrack 0 Mar 20 15:11:43 volumio2 volumio[938]: info: CoreCommandRouter::volumioPushState Mar 20 15:11:43 volumio2 volumio[938]: info: CoreStateMachine::setRandom null Mar 20 15:11:43 volumio2 volumio[938]: info: CoreStateMachine::pushState Mar 20 15:11:43 volumio2 volumio[938]: info: CorePlayQueue::getTrack 0 Mar 20 15:11:43 volumio2 volumio[938]: info: CoreCommandRouter::volumioPushState Mar 20 15:11:43 volumio2 volumio[938]: info: Setting Device type: Raspberry PI Mar 20 15:11:43 volumio2 volumio[938]: verbose: New Socket.io Connection to 192.168.0.32:3000 from 192.168.0.30 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 20 15:11:43 volumio2 volumio[938]: info: Mar 20 15:11:43 volumio2 volumio[938]: ---------------------------- Client requests Volumio Play Playlist chime Mar 20 15:11:43 volumio2 volumio[938]: info: Play playlist chime Mar 20 15:11:44 volumio2 volumio[938]: Starting albumart workers Mar 20 15:11:44 volumio2 sudo[1201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 20 15:11:44 volumio2 sudo[1201]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 20 15:11:44 volumio2 volumio[938]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Mar 20 15:11:44 volumio2 systemd[1]: Started UPnP Renderer front-end to MPD. Mar 20 15:11:44 volumio2 sudo[1201]: pam_unix(sudo:session): session closed for user root Mar 20 15:11:45 volumio2 volumio[938]: info: Discovery: adding 888a0689-2307-471b-abe1-ccd9ee3d9a63 Mar 20 15:11:45 volumio2 volumio[938]: info: Discovery: Found device Volumio2 Mar 20 15:11:45 volumio2 volumio[938]: info: CoreCommandRouter::volumioGetState Mar 20 15:11:45 volumio2 volumio[938]: info: CorePlayQueue::getTrack 0 Mar 20 15:11:45 volumio2 volumio[938]: info: VolumeController:: Volume=80 Mute =false Mar 20 15:11:45 volumio2 volumio[938]: info: CoreStateMachine::pushState Mar 20 15:11:45 volumio2 volumio[938]: info: CorePlayQueue::getTrack 0 Mar 20 15:11:45 volumio2 volumio[938]: info: CoreCommandRouter::volumioPushState Mar 20 15:11:45 volumio2 volumio[938]: info: CoreCommandRouter::volumioGetState Mar 20 15:11:45 volumio2 volumio[938]: info: CorePlayQueue::getTrack 0 Mar 20 15:11:46 volumio2 volumio[938]: info: Upmpdcli Daemon Started Mar 20 15:11:46 volumio2 volumio[938]: info: Completed loading Core Plugins Mar 20 15:11:46 volumio2 volumio[938]: info: Preparing to generate the ALSA configuration file Mar 20 15:11:46 volumio2 volumio[938]: info: CoreCommandRouter::volumioClearQueue Mar 20 15:11:46 volumio2 volumio[938]: info: CoreStateMachine::ClearQueue Mar 20 15:11:46 volumio2 volumio[938]: info: CoreStateMachine::stop Mar 20 15:11:46 volumio2 volumio[938]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 20 15:11:46 volumio2 volumio[938]: info: CorePlayQueue::clearPlayQueue Mar 20 15:11:46 volumio2 volumio[938]: info: CorePlayQueue::saveQueue Mar 20 15:11:46 volumio2 volumio[938]: info: CoreCommandRouter::volumioPushState Mar 20 15:11:46 volumio2 volumio[938]: info: CoreCommandRouter::volumioPushQueue Mar 20 15:11:46 volumio2 volumio[938]: info: CoreCommandRouter::volumioAddQueueItems Mar 20 15:11:46 volumio2 volumio[938]: info: CoreStateMachine::addQueueItems Mar 20 15:11:46 volumio2 volumio[938]: info: CorePlayQueue::addQueueItems Mar 20 15:11:46 volumio2 volumio[938]: info: Preload queue cleared Mar 20 15:11:46 volumio2 volumio[938]: info: Adding Item to queue: mnt/INTERNAL/chime.mp3 Mar 20 15:11:46 volumio2 volumio[938]: info: Exploding uri mnt/INTERNAL/chime.mp3 in service mpd Mar 20 15:11:46 volumio2 volumio[938]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 20 15:11:46 volumio2 volumio[938]: TypeError: Cannot read property 'then' of undefined Mar 20 15:11:46 volumio2 volumio[938]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2528:19) Mar 20 15:11:46 volumio2 volumio[938]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2326:21) Mar 20 15:11:46 volumio2 volumio[938]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1378:16) Mar 20 15:11:46 volumio2 volumio[938]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Mar 20 15:11:46 volumio2 volumio[938]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Mar 20 15:11:46 volumio2 volumio[938]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Mar 20 15:11:46 volumio2 volumio[938]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Mar 20 15:11:46 volumio2 volumio[938]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:448:28) Mar 20 15:11:46 volumio2 volumio[938]: at /volumio/app/playlistManager.js:726:30 Mar 20 15:11:46 volumio2 volumio[938]: at /volumio/node_modules/jsonfile/index.js:46:5 Mar 20 15:11:46 volumio2 volumio[938]: at /volumio/node_modules/graceful-fs/graceful-fs.js:123:16 Mar 20 15:11:46 volumio2 volumio[938]: at FSReqCallback.readFileAfterClose [as oncomplete] (internal/fs/read_file_context.js:63:3) Mar 20 15:11:47 volumio2 volumio[938]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 20 15:11:48 volumio2 volumio-remote-updater[439]: [2025-03-20 15:11:48] [connect] Successful connection Mar 20 15:11:53 volumio2 sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-20 15:10 Mar 20 15:11:53 volumio2 sudo[1238]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"