-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Wed 2025-05-14 18:38:45 CST. -- May 14 18:37:56 dac.x1 systemd-timedated[978]: Changed local time to Wed May 14 18:37:56 2025 May 14 18:37:56 dac.x1 sudo[976]: pam_unix(sudo:session): session closed for user root May 14 18:37:56 dac.x1 volumio-time-update[563]: volumio-time-update-util: System time updated successfully. May 14 18:37:56 dac.x1 systemd[1]: Started Volumio Time Update Utility. May 14 18:37:56 dac.x1 systemd[1]: Starting Daily man-db regeneration... May 14 18:37:56 dac.x1 systemd[1]: Starting Daily apt download activities... May 14 18:37:56 dac.x1 nmbd[723]: [2025/05/14 18:37:56.364218, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 14 18:37:56 dac.x1 nmbd[723]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.3.10 for name WORKGROUP<1d>. May 14 18:37:56 dac.x1 nmbd[723]: This response was from IP 192.168.3.31, reporting an IP address of 192.168.3.31. May 14 18:37:56 dac.x1 systemd[1]: man-db.service: Succeeded. May 14 18:37:56 dac.x1 systemd[1]: Started Daily man-db regeneration. May 14 18:37:56 dac.x1 wireless.js[587]: trying... May 14 18:37:56 dac.x1 sudo[1005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:37:56 dac.x1 sudo[1005]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:37:56 dac.x1 sudo[1005]: pam_unix(sudo:session): session closed for user root May 14 18:37:57 dac.x1 volumio-remote-updater[590]: [2025-05-14 18:37:57] [info] asio async_connect error: system:111 (Connection refused) May 14 18:37:57 dac.x1 volumio-remote-updater[590]: [2025-05-14 18:37:57] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 14 18:37:57 dac.x1 volumio-remote-updater[590]: [2025-05-14 18:37:57] [error] handle_connect error: Underlying Transport Error May 14 18:37:57 dac.x1 wireless.js[587]: trying... May 14 18:37:57 dac.x1 sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:37:57 dac.x1 sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:37:57 dac.x1 sudo[1009]: pam_unix(sudo:session): session closed for user root May 14 18:37:58 dac.x1 wireless.js[587]: trying... May 14 18:37:58 dac.x1 sudo[1012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:37:58 dac.x1 sudo[1012]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:37:58 dac.x1 sudo[1012]: pam_unix(sudo:session): session closed for user root May 14 18:37:59 dac.x1 systemd[1]: apt-daily.service: Succeeded. May 14 18:37:59 dac.x1 systemd[1]: Started Daily apt download activities. May 14 18:37:59 dac.x1 systemd[1]: Starting Daily apt upgrade and clean activities... May 14 18:37:59 dac.x1 wireless.js[587]: trying... May 14 18:37:59 dac.x1 sudo[1066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:37:59 dac.x1 sudo[1066]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:37:59 dac.x1 sudo[1066]: pam_unix(sudo:session): session closed for user root May 14 18:38:00 dac.x1 wireless.js[587]: trying... May 14 18:38:00 dac.x1 sudo[1077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:00 dac.x1 sudo[1077]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:00 dac.x1 sudo[1077]: pam_unix(sudo:session): session closed for user root May 14 18:38:01 dac.x1 systemd[1]: apt-daily-upgrade.service: Succeeded. May 14 18:38:01 dac.x1 systemd[1]: Started Daily apt upgrade and clean activities. May 14 18:38:01 dac.x1 wireless.js[587]: trying... May 14 18:38:01 dac.x1 sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:01 dac.x1 sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:01 dac.x1 sudo[1101]: pam_unix(sudo:session): session closed for user root May 14 18:38:02 dac.x1 wireless.js[587]: trying... May 14 18:38:02 dac.x1 sudo[1104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:02 dac.x1 sudo[1104]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:02 dac.x1 sudo[1104]: pam_unix(sudo:session): session closed for user root May 14 18:38:03 dac.x1 wireless.js[587]: trying... May 14 18:38:03 dac.x1 sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:03 dac.x1 sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:03 dac.x1 sudo[1107]: pam_unix(sudo:session): session closed for user root May 14 18:38:04 dac.x1 wireless.js[587]: trying... May 14 18:38:04 dac.x1 sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:04 dac.x1 sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:04 dac.x1 sudo[1110]: pam_unix(sudo:session): session closed for user root May 14 18:38:05 dac.x1 wireless.js[587]: trying... May 14 18:38:05 dac.x1 sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:05 dac.x1 sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:05 dac.x1 sudo[1113]: pam_unix(sudo:session): session closed for user root May 14 18:38:06 dac.x1 wireless.js[587]: trying... May 14 18:38:06 dac.x1 sudo[1116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:06 dac.x1 sudo[1116]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:06 dac.x1 sudo[1116]: pam_unix(sudo:session): session closed for user root May 14 18:38:07 dac.x1 volumio-remote-updater[590]: [2025-05-14 18:38:07] [info] asio async_connect error: system:111 (Connection refused) May 14 18:38:07 dac.x1 volumio-remote-updater[590]: [2025-05-14 18:38:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 14 18:38:07 dac.x1 volumio-remote-updater[590]: [2025-05-14 18:38:07] [error] handle_connect error: Underlying Transport Error May 14 18:38:07 dac.x1 wireless.js[587]: trying... May 14 18:38:07 dac.x1 sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:07 dac.x1 sudo[1119]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:07 dac.x1 sudo[1119]: pam_unix(sudo:session): session closed for user root May 14 18:38:08 dac.x1 wireless.js[587]: trying... May 14 18:38:08 dac.x1 sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:08 dac.x1 sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:08 dac.x1 sudo[1122]: pam_unix(sudo:session): session closed for user root May 14 18:38:09 dac.x1 wireless.js[587]: trying... May 14 18:38:09 dac.x1 sudo[1128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 14 18:38:09 dac.x1 sudo[1128]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:09 dac.x1 sudo[1128]: pam_unix(sudo:session): session closed for user root May 14 18:38:10 dac.x1 wpa_supplicant[853]: wlan0: Failed to initiate sched scan May 14 18:38:10 dac.x1 wireless.js[587]: Overtime, starting plan B May 14 18:38:10 dac.x1 systemd[1]: Started Wireless Services. May 14 18:38:10 dac.x1 kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled May 14 18:38:10 dac.x1 systemd[1]: Started Volumio Backend Module. May 14 18:38:10 dac.x1 systemd[1]: Started Volumio Cpu Tweaker. May 14 18:38:10 dac.x1 systemd[1]: Reached target Multi-User System. May 14 18:38:10 dac.x1 systemd[1]: Reached target Graphical Interface. May 14 18:38:10 dac.x1 systemd[1]: Starting Update UTMP about System Runlevel Changes... May 14 18:38:10 dac.x1 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 14 18:38:10 dac.x1 volumio-cpu-tweak[1134]: Setting RT Priority for mpd May 14 18:38:10 dac.x1 systemd[1]: Started Update UTMP about System Runlevel Changes. May 14 18:38:10 dac.x1 systemd[1]: Startup finished in 13.249s (kernel) + 31.677s (userspace) = 44.927s. May 14 18:38:10 dac.x1 volumio-cpu-tweak[1134]: Setting MPD Affinity May 14 18:38:10 dac.x1 volumio-cpu-tweak[1134]: pid 788's current affinity mask: f May 14 18:38:10 dac.x1 volumio-cpu-tweak[1134]: pid 788's new affinity mask: 3 May 14 18:38:10 dac.x1 volumio-cpu-tweak[1134]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 14 18:38:10 dac.x1 volumio-cpu-tweak[1134]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 14 18:38:10 dac.x1 systemd[1]: volumio_cpu_tweak.service: Succeeded. May 14 18:38:12 dac.x1 systemd[1]: systemd-fsckd.service: Succeeded. May 14 18:38:13 dac.x1 volumio[1133]: info: ------------------------------------------- May 14 18:38:13 dac.x1 volumio[1133]: info: ----- Volumio3 ---- May 14 18:38:13 dac.x1 volumio[1133]: info: ------------------------------------------- May 14 18:38:13 dac.x1 volumio[1133]: info: ----- System startup ---- May 14 18:38:13 dac.x1 volumio[1133]: info: ------------------------------------------- May 14 18:38:14 dac.x1 volumio[1133]: info: MYVOLUMIO Environment detected May 14 18:38:14 dac.x1 volumio[1133]: info: Plugin folders cleanup May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning into folder /volumio/app/plugins/ May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning category audio_interface May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning category miscellanea May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning category music_service May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning category plugins.json May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning category system_controller May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning category user_interface May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning into folder /data/plugins/ May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning category music_service May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning category system_hardware May 14 18:38:14 dac.x1 volumio[1133]: info: Scanning category user_interface May 14 18:38:14 dac.x1 volumio[1133]: info: Plugin folders cleanup completed May 14 18:38:14 dac.x1 volumio[1133]: info: ------------------------------------------- May 14 18:38:14 dac.x1 volumio[1133]: info: ----- Core plugins startup ---- May 14 18:38:14 dac.x1 volumio[1133]: info: ------------------------------------------- May 14 18:38:14 dac.x1 volumio[1133]: info: Loading plugins from folder /volumio/app/plugins/ May 14 18:38:14 dac.x1 volumio[1133]: info: Adding plugin upnp to MyMusic Plugins May 14 18:38:14 dac.x1 volumio[1133]: info: Adding plugin airplay_emulation to MyMusic Plugins May 14 18:38:14 dac.x1 volumio[1133]: info: Adding plugin upnp_browser to MyMusic Plugins May 14 18:38:14 dac.x1 volumio[1133]: info: Loading plugins from folder /data/plugins/ May 14 18:38:14 dac.x1 volumio[1133]: info: Loading plugin "system"... May 14 18:38:14 dac.x1 volumio[1133]: info: Loading plugin "appearance"... May 14 18:38:16 dac.x1 systemd[1]: systemd-hostnamed.service: Succeeded. May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "network"... May 14 18:38:16 dac.x1 volumio[1133]: info: Refreshing Cached IP Addresses May 14 18:38:16 dac.x1 sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 14 18:38:16 dac.x1 sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:16 dac.x1 sudo[1170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 14 18:38:16 dac.x1 sudo[1168]: pam_unix(sudo:session): session closed for user root May 14 18:38:16 dac.x1 sudo[1170]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "services"... May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "alsa_controller"... May 14 18:38:16 dac.x1 sudo[1170]: pam_unix(sudo:session): session closed for user root May 14 18:38:16 dac.x1 sudo[1180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 14 18:38:16 dac.x1 sudo[1180]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:16 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "wizard"... May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "networkfs"... May 14 18:38:16 dac.x1 volumio[1133]: info: Starting Udev Watcher for removable devices May 14 18:38:16 dac.x1 volumio[1133]: info: Ignoring mount for partition: boot May 14 18:38:16 dac.x1 volumio[1133]: info: Ignoring mount for partition: volumio May 14 18:38:16 dac.x1 volumio[1133]: info: Ignoring mount for partition: volumio_data May 14 18:38:16 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "volumio_command_line_client"... May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "upnp"... May 14 18:38:16 dac.x1 volumio[1133]: info: [1747219096441] Starting Upmpd Daemon May 14 18:38:16 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "my_music"... May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "mpd"... May 14 18:38:16 dac.x1 volumio[1133]: info: Loading plugin "upnp_browser"... May 14 18:38:17 dac.x1 volumio[1133]: info: Loading plugin "alarm-clock"... May 14 18:38:17 dac.x1 volumio[1133]: info: Loading plugin "airplay_emulation"... May 14 18:38:17 dac.x1 volumio[1133]: info: Starting Shairport Sync May 14 18:38:17 dac.x1 volumio[1133]: info: Loading plugin "last_100"... May 14 18:38:17 dac.x1 volumio[1133]: info: Loading plugin "webradio"... May 14 18:38:17 dac.x1 volumio[1133]: info: Loading plugin "i2s_dacs"... May 14 18:38:17 dac.x1 volumio[1133]: info: Loading plugin "volumiodiscovery"... May 14 18:38:17 dac.x1 volumio[1133]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 14 18:38:17 dac.x1 volumio[1133]: *** WARNING *** Please fix your application to use the native API of Avahi! May 14 18:38:17 dac.x1 volumio[1133]: *** WARNING *** For more information see May 14 18:38:17 dac.x1 node[1133]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 14 18:38:17 dac.x1 volumio[1133]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 14 18:38:17 dac.x1 volumio[1133]: *** WARNING *** Please fix your application to use the native API of Avahi! May 14 18:38:17 dac.x1 volumio[1133]: *** WARNING *** For more information see May 14 18:38:17 dac.x1 node[1133]: *** WARNING *** Please fix your application to use the native API of Avahi! May 14 18:38:17 dac.x1 node[1133]: *** WARNING *** For more information see May 14 18:38:17 dac.x1 node[1133]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 14 18:38:17 dac.x1 node[1133]: *** WARNING *** Please fix your application to use the native API of Avahi! May 14 18:38:17 dac.x1 node[1133]: *** WARNING *** For more information see May 14 18:38:17 dac.x1 volumio[1133]: info: Applying required configuration parameters for plugin volumiodiscovery May 14 18:38:17 dac.x1 volumio[1133]: info: Discovery: Started advertising with name: DAC.x1 May 14 18:38:17 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 14 18:38:17 dac.x1 volumio[1133]: info: Loading plugin "spop"... May 14 18:38:18 dac.x1 volumio-remote-updater[590]: [2025-05-14 18:38:18] [connect] Successful connection May 14 18:38:18 dac.x1 sudo[1195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Volumio,password=#music#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.31/Volumio /mnt/NAS/Volumio May 14 18:38:18 dac.x1 wpa_supplicant[853]: wlan0: Failed to initiate sched scan May 14 18:38:18 dac.x1 sudo[1195]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:18 dac.x1 kernel: Key type cifs.spnego registered May 14 18:38:18 dac.x1 kernel: Key type cifs.idmap registered May 14 18:38:18 dac.x1 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. May 14 18:38:18 dac.x1 kernel: CIFS: Attempting to mount //192.168.3.31/Volumio May 14 18:38:19 dac.x1 kernel: cryptd: max_cpu_qlen set to 1000 May 14 18:38:19 dac.x1 sudo[1195]: pam_unix(sudo:session): session closed for user root May 14 18:38:19 dac.x1 kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE May 14 18:38:19 dac.x1 kernel: CIFS: VFS: \\192.168.3.31 Send error in SessSetup = -13 May 14 18:38:19 dac.x1 kernel: CIFS: VFS: cifs_mount failed w/return code = -13 May 14 18:38:19 dac.x1 sudo[1180]: pam_unix(sudo:session): session closed for user root May 14 18:38:19 dac.x1 volumio[1133]: info: Plugin now_playing is not enabled May 14 18:38:19 dac.x1 volumio[1133]: info: Loading plugin "outputs"... May 14 18:38:19 dac.x1 volumio[1133]: info: Loading plugin "albumart"... May 14 18:38:19 dac.x1 volumio[1133]: info: Plugin example_plugin is not enabled May 14 18:38:19 dac.x1 volumio[1133]: info: Loading plugin "inputs"... May 14 18:38:19 dac.x1 volumio[1133]: info: Loading plugin "updater_comm"... May 14 18:38:20 dac.x1 volumio[1133]: info: Plugin mpdemulation is not enabled May 14 18:38:20 dac.x1 volumio[1133]: info: Loading plugin "rest_api"... May 14 18:38:20 dac.x1 volumio[1133]: info: Loading plugin "websocket"... May 14 18:38:20 dac.x1 volumio[1133]: info: Starting Socket.io Server version 2.3.0 May 14 18:38:20 dac.x1 volumio[1133]: info: Plugin rotaryencoder2 is not enabled May 14 18:38:20 dac.x1 volumio[1133]: info: Loading plugin "Systeminfo"... May 14 18:38:20 dac.x1 volumio[1133]: Forking 3 albumart workers May 14 18:38:20 dac.x1 volumio[1133]: info: Loading plugin "peppymeterbasic"... May 14 18:38:21 dac.x1 volumio[1133]: Starting albumart workers May 14 18:38:21 dac.x1 volumio[1133]: Starting albumart workers May 14 18:38:21 dac.x1 volumio[1133]: Starting albumart workers May 14 18:38:21 dac.x1 volumio[1133]: info: Plugin peppyspectrum is not enabled May 14 18:38:21 dac.x1 volumio[1133]: info: Loading plugin "touch_display"... May 14 18:38:22 dac.x1 volumio[1133]: info: Applying required configuration parameters for plugin touch_display May 14 18:38:22 dac.x1 volumio[1133]: info: Loading i18n strings for locale en May 14 18:38:22 dac.x1 volumio[1133]: Updating browse sources language May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::initPlayerControls May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: Express server listening on port 3000 May 14 18:38:22 dac.x1 volumio[1133]: [Metrics] WebUI: 10s 24.12ms May 14 18:38:22 dac.x1 volumio[1133]: info: CoreStateMachine::resetVolumioState May 14 18:38:22 dac.x1 volumio[1133]: info: CoreStateMachine::getcurrentVolume May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioRetrievevolume May 14 18:38:22 dac.x1 volumio[1133]: info: CoreStateMachine::pushState May 14 18:38:22 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioPushState May 14 18:38:22 dac.x1 volumio[1133]: info: Volumio Network Manager: Network status updated: 1 May 14 18:38:22 dac.x1 volumio[1133]: info: Cannot mount NAS Volumio at system boot, trial number 1 ,retrying in 5 seconds May 14 18:38:22 dac.x1 volumio-remote-updater[590]: [2025-05-14 18:38:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747219097 101 May 14 18:38:22 dac.x1 volumio[1133]: 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: 1 May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 14 18:38:22 dac.x1 volumio[1133]: info: Discovery: Getting this device information May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:22 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 18:38:22 dac.x1 volumio[1133]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 14 18:38:22 dac.x1 volumio[1133]: info: Reloading queue from file May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:22 dac.x1 volumio[1133]: info: CoreStateMachine::setRepeat null single undefined May 14 18:38:22 dac.x1 volumio[1133]: info: CoreStateMachine::pushState May 14 18:38:22 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioPushState May 14 18:38:22 dac.x1 volumio[1133]: info: CoreStateMachine::setRandom null May 14 18:38:22 dac.x1 volumio[1133]: info: CoreStateMachine::pushState May 14 18:38:22 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:22 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioPushState May 14 18:38:22 dac.x1 volumio[1133]: info: Setting Device type: Raspberry PI May 14 18:38:22 dac.x1 volumio[1133]: info: Completed loading Core Plugins May 14 18:38:22 dac.x1 volumio[1133]: info: Preparing to generate the ALSA configuration file May 14 18:38:22 dac.x1 volumio[1133]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf May 14 18:38:22 dac.x1 volumio[1133]: info: Reading ALSA contributions from plugins. May 14 18:38:22 dac.x1 volumio[1133]: info: Asound.conf file unchanged, so no further update is needed May 14 18:38:22 dac.x1 volumio[1133]: info: Output device has changed, restarting MPD May 14 18:38:23 dac.x1 volumio[1133]: info: Output device has changed, restarting Shairport Sync May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:23 dac.x1 sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 14 18:38:23 dac.x1 sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:23 dac.x1 sudo[1298]: pam_unix(sudo:session): session closed for user root May 14 18:38:23 dac.x1 sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 14 18:38:23 dac.x1 sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:23 dac.x1 systemd[1]: Stopping Music Player Daemon... May 14 18:38:23 dac.x1 volumio[1133]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 14 18:38:23 dac.x1 volumio[1133]: info: ___________ START PLUGINS ___________ May 14 18:38:23 dac.x1 volumio[1133]: info: ControllerMpd::onStart: Initializing MPD May 14 18:38:23 dac.x1 volumio[1133]: info: Creating MPD Configuration file May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 14 18:38:23 dac.x1 volumio[1133]: info: [1747219103107] CoreMusicLibrary::Adding element Media Servers May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 18:38:23 dac.x1 sudo[1307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 14 18:38:23 dac.x1 sudo[1307]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:23 dac.x1 sudo[1307]: pam_unix(sudo:session): session closed for user root May 14 18:38:23 dac.x1 sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 14 18:38:23 dac.x1 sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:23 dac.x1 systemd[1]: mpd.service: Succeeded. May 14 18:38:23 dac.x1 systemd[1]: Stopped Music Player Daemon. May 14 18:38:23 dac.x1 volumio[1133]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 14 18:38:23 dac.x1 volumio[1133]: info: [1747219103243] CoreMusicLibrary::Adding element Last_100 May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 14 18:38:23 dac.x1 volumio[1133]: info: [1747219103246] CoreMusicLibrary::Adding element Webradio May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 14 18:38:23 dac.x1 volumio[1133]: info: Initializing BBC Radios May 14 18:38:23 dac.x1 systemd[1]: Starting Music Player Daemon... May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: Creating Spotify config file May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 sudo[1318]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 14 18:38:23 dac.x1 sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:23 dac.x1 sudo[1318]: pam_unix(sudo:session): session closed for user root May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 14 18:38:23 dac.x1 volumio[1133]: info: Loading i18n strings for locale en May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 14 18:38:23 dac.x1 volumio[1133]: info: Volumio Calling Home May 14 18:38:23 dac.x1 volumio[1133]: info: Preparing to generate the ALSA configuration file May 14 18:38:23 dac.x1 sudo[1335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service May 14 18:38:23 dac.x1 sudo[1335]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:23 dac.x1 sudo[1337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service May 14 18:38:23 dac.x1 sudo[1337]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:23 dac.x1 sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 14 18:38:23 dac.x1 sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:23 dac.x1 volumio[1133]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf May 14 18:38:23 dac.x1 volumio[1133]: info: Reading ALSA contributions from plugins. May 14 18:38:23 dac.x1 volumio[1133]: info: touch_display: No backlight interface detected. May 14 18:38:23 dac.x1 systemd[1]: Reloading. May 14 18:38:23 dac.x1 volumio[1133]: verbose: New Socket.io Connection to 192.168.3.10:3000 from 192.168.3.4 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 May 14 18:38:23 dac.x1 volumio[1133]: info: MPD Permissions set May 14 18:38:23 dac.x1 volumio[1133]: info: MPD Permissions set May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:23 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 14 18:38:23 dac.x1 volumio[1133]: info: Spotify config file written May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 sudo[1345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service May 14 18:38:23 dac.x1 sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:23 dac.x1 volumio[1133]: info: No need to fix Spotify hosts May 14 18:38:24 dac.x1 volumio[1133]: info: Discovery: adding 994a5466-2072-4565-b41d-86e118e13134 May 14 18:38:24 dac.x1 volumio[1133]: info: Discovery: Found device DAC.x1 May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:24 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:24 dac.x1 volumio[1133]: info: touch_display: No Raspberry Pi Foundation touch screen detected. May 14 18:38:24 dac.x1 sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf May 14 18:38:24 dac.x1 sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:24 dac.x1 sudo[1369]: pam_unix(sudo:session): session closed for user root May 14 18:38:24 dac.x1 sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf May 14 18:38:24 dac.x1 sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:24 dac.x1 volumio[1133]: info: Starting Shairport Sync May 14 18:38:24 dac.x1 sudo[1371]: pam_unix(sudo:session): session closed for user root May 14 18:38:24 dac.x1 volumio[1133]: info: Starting Shairport Sync May 14 18:38:24 dac.x1 volumio[1133]: info: Starting Shairport Sync May 14 18:38:24 dac.x1 sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 14 18:38:24 dac.x1 sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:24 dac.x1 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 14 18:38:24 dac.x1 volumio[1133]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 14 18:38:24 dac.x1 volumio[1133]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 May 14 18:38:24 dac.x1 volumio[1133]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. May 14 18:38:24 dac.x1 sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 14 18:38:24 dac.x1 volumio[1133]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Wet%20Wet%20Wet/End%20Of%20Part%20One.%20Their%20Greatest%20Hits/ec0204a1-f236-435e-b5fd-f22be443503f.jpg' May 14 18:38:24 dac.x1 sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:24 dac.x1 sudo[1380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 14 18:38:24 dac.x1 sudo[1380]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:24 dac.x1 volumio[1133]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. May 14 18:38:24 dac.x1 volumio[1133]: info: Asound.conf file unchanged, so no further update is needed May 14 18:38:24 dac.x1 volumio[1133]: info: Output device has changed, restarting MPD May 14 18:38:24 dac.x1 volumio[1133]: info: Output device has changed, restarting Shairport Sync May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:24 dac.x1 sudo[1384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 14 18:38:24 dac.x1 sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:24 dac.x1 sudo[1386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 14 18:38:24 dac.x1 sudo[1386]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:24 dac.x1 sudo[1384]: pam_unix(sudo:session): session closed for user root May 14 18:38:24 dac.x1 volumio[1133]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 14 18:38:24 dac.x1 volumio[1133]: info: MPD Permissions set May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:24 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 14 18:38:24 dac.x1 volumio[1133]: info: Starting Shairport Sync May 14 18:38:24 dac.x1 sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 14 18:38:24 dac.x1 sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:24 dac.x1 sudo[1340]: pam_unix(sudo:session): session closed for user root May 14 18:38:24 dac.x1 volumio[1133]: info: touch_display: systemctl daemon-reload succeeded. May 14 18:38:24 dac.x1 sudo[1335]: pam_unix(sudo:session): session closed for user root May 14 18:38:24 dac.x1 volumio[1133]: info: touch_display: systemctl stop getty@tty1.service succeeded. May 14 18:38:24 dac.x1 systemd[1]: Reloading. May 14 18:38:24 dac.x1 sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 14 18:38:24 dac.x1 sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:24 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:25 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:25 dac.x1 volumio[1133]: info: Volumio called home May 14 18:38:25 dac.x1 mpd[1330]: May 14 18:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 14 18:38:25 dac.x1 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 14 18:38:25 dac.x1 systemd[1]: Started Music Player Daemon. May 14 18:38:25 dac.x1 sudo[1337]: pam_unix(sudo:session): session closed for user root May 14 18:38:25 dac.x1 sudo[1300]: pam_unix(sudo:session): session closed for user root May 14 18:38:25 dac.x1 volumio[1133]: info: touch_display: systemctl disable getty@tty1.service succeeded. May 14 18:38:25 dac.x1 sudo[1309]: pam_unix(sudo:session): session closed for user root May 14 18:38:25 dac.x1 volumio[1133]: error: MPD error: The expression evaluated to a falsy value: May 14 18:38:25 dac.x1 volumio[1133]: assert.ok(self.idling) May 14 18:38:25 dac.x1 volumio[1133]: error: The expression evaluated to a falsy value: May 14 18:38:25 dac.x1 volumio[1133]: assert.ok(self.idling) May 14 18:38:25 dac.x1 volumio[1133]: info: MPD running with PID1330 May 14 18:38:25 dac.x1 volumio[1133]: ,establishing connection May 14 18:38:25 dac.x1 volumio[1133]: error: updateQueue error: null May 14 18:38:25 dac.x1 volumio[1133]: error: updateQueue error: null May 14 18:38:25 dac.x1 systemd[1]: Started Volumio Kiosk. May 14 18:38:25 dac.x1 systemd[1]: Stopping Music Player Daemon... May 14 18:38:25 dac.x1 sudo[1403]: pam_unix(sudo:session): session closed for user root May 14 18:38:25 dac.x1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 14 18:38:25 dac.x1 systemd[1]: Started go-librespot Daemon. May 14 18:38:25 dac.x1 sudo[1345]: pam_unix(sudo:session): session closed for user root May 14 18:38:25 dac.x1 go-librespot[1424]: go-librespot daemon starting... May 14 18:38:25 dac.x1 volumio[1133]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 14 18:38:25 dac.x1 volumio[1133]: info: touch_display: Volumio Kiosk started. May 14 18:38:25 dac.x1 systemd[1]: shairport-sync.service: Succeeded. May 14 18:38:25 dac.x1 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 14 18:38:25 dac.x1 systemd[1]: mpd.service: Succeeded. May 14 18:38:25 dac.x1 systemd[1]: Stopped Music Player Daemon. May 14 18:38:25 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:25 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:25 dac.x1 volumio[1133]: info: Completed starting Core Plugins May 14 18:38:25 dac.x1 volumio[1133]: info: ------------------------------------------- May 14 18:38:25 dac.x1 volumio[1133]: info: ----- MyVolumio plugins startup ---- May 14 18:38:25 dac.x1 volumio[1133]: info: ------------------------------------------- May 14 18:38:25 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Fetching plans data.... May 14 18:38:25 dac.x1 systemd[1]: Starting Music Player Daemon... May 14 18:38:25 dac.x1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 14 18:38:25 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:25 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:25 dac.x1 sudo[1380]: pam_unix(sudo:session): session closed for user root May 14 18:38:25 dac.x1 sudo[1400]: pam_unix(sudo:session): session closed for user root May 14 18:38:25 dac.x1 sudo[1377]: pam_unix(sudo:session): session closed for user root May 14 18:38:25 dac.x1 sudo[1375]: pam_unix(sudo:session): session closed for user root May 14 18:38:26 dac.x1 volumio[1133]: info: Shairport-Sync Started May 14 18:38:26 dac.x1 volumio[1133]: Error adding Membership: Error: addMembership EINVAL May 14 18:38:26 dac.x1 volumio[1133]: info: Shairport-Sync Started May 14 18:38:26 dac.x1 systemd[1]: systemd-timedated.service: Succeeded. May 14 18:38:26 dac.x1 volumio[1133]: info: Shairport-Sync Started May 14 18:38:26 dac.x1 volumio[1133]: info: Shairport-Sync Started May 14 18:38:26 dac.x1 volumio[1133]: info: touch_display: X display number found: May 14 18:38:26 dac.x1 volumio[1133]: info: touch_display: X display number found: 0 May 14 18:38:26 dac.x1 sudo[1439]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 14 18:38:26 dac.x1 sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:26 dac.x1 sudo[1439]: pam_unix(sudo:session): session closed for user root May 14 18:38:26 dac.x1 volumio[1133]: info: touch_display: X display number found: 0 May 14 18:38:26 dac.x1 startx[1422]: X.Org X Server 1.20.4 May 14 18:38:26 dac.x1 startx[1422]: X Protocol Version 11, Revision 0 May 14 18:38:26 dac.x1 startx[1422]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian May 14 18:38:26 dac.x1 startx[1422]: Current Operating System: Linux dac.x1 6.6.62-v7+ #1816 SMP Mon Nov 18 15:30:49 GMT 2024 armv7l May 14 18:38:26 dac.x1 startx[1422]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_hdmi=0 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=fb80cb44-b4d3-4b36-be35-613cba0a09fb imgfile=/volumio_current.sqsh bootpart=UUID=51B1-040D datapart=UUID=2899bccc-8620-4c7a-b56a-43fd2f7a836a uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no May 14 18:38:26 dac.x1 startx[1422]: Build Date: 04 April 2023 07:50:56AM May 14 18:38:26 dac.x1 startx[1422]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) May 14 18:38:26 dac.x1 startx[1422]: Current version of pixman: 0.36.0 May 14 18:38:26 dac.x1 startx[1422]: Before reporting problems, check http://wiki.x.org May 14 18:38:26 dac.x1 startx[1422]: to make sure that you have the latest version. May 14 18:38:26 dac.x1 startx[1422]: Markers: (--) probed, (**) from config file, (==) default setting, May 14 18:38:26 dac.x1 startx[1422]: (++) from command line, (!!) notice, (II) informational, May 14 18:38:26 dac.x1 startx[1422]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 14 18:38:26 dac.x1 startx[1422]: (==) Log file: "/var/log/Xorg.0.log", Time: Wed May 14 18:38:26 2025 May 14 18:38:26 dac.x1 volumio[1133]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 14 18:38:26 dac.x1 volumio[1133]: info: touch_display: X display number found: 0 May 14 18:38:26 dac.x1 startx[1422]: (==) Using config directory: "/etc/X11/xorg.conf.d" May 14 18:38:26 dac.x1 startx[1422]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 14 18:38:26 dac.x1 sudo[1485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 14 18:38:26 dac.x1 sudo[1485]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:26 dac.x1 sudo[1487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 14 18:38:26 dac.x1 sudo[1485]: pam_unix(sudo:session): session closed for user root May 14 18:38:26 dac.x1 sudo[1487]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:26 dac.x1 sudo[1487]: pam_unix(sudo:session): session closed for user root May 14 18:38:26 dac.x1 sudo[1491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 14 18:38:26 dac.x1 sudo[1491]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:26 dac.x1 go-librespot[1424]: time="2025-05-14T18:38:26+08:00" level=info msg="running go-librespot 0.2.0" May 14 18:38:26 dac.x1 go-librespot[1424]: time="2025-05-14T18:38:26+08:00" level=debug msg="app state loaded" May 14 18:38:26 dac.x1 go-librespot[1424]: time="2025-05-14T18:38:26+08:00" level=debug msg="stored credentials not found" May 14 18:38:26 dac.x1 go-librespot[1424]: time="2025-05-14T18:38:26+08:00" level=info msg="api server listening on 127.0.0.1:9879" May 14 18:38:26 dac.x1 systemd[1]: Started UPnP Renderer front-end to MPD. May 14 18:38:26 dac.x1 sudo[1491]: pam_unix(sudo:session): session closed for user root May 14 18:38:26 dac.x1 volumio[1133]: info: Upmpdcli Daemon Started May 14 18:38:26 dac.x1 volumio[1133]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Wet%20Wet%20Wet/End%20Of%20Part%20One.%20Their%20Greatest%20Hits/ec0204a1-f236-435e-b5fd-f22be443503f.jpg' May 14 18:38:27 dac.x1 wpa_supplicant[853]: wlan0: Failed to initiate sched scan May 14 18:38:27 dac.x1 sudo[1495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Volumio,password=#music#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.31/Volumio /mnt/NAS/Volumio May 14 18:38:27 dac.x1 sudo[1495]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:27 dac.x1 mpd[1463]: May 14 18:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 14 18:38:27 dac.x1 systemd[1]: Started Music Player Daemon. May 14 18:38:27 dac.x1 kernel: CIFS: Attempting to mount //192.168.3.31/Volumio May 14 18:38:27 dac.x1 sudo[1386]: pam_unix(sudo:session): session closed for user root May 14 18:38:27 dac.x1 sudo[1495]: pam_unix(sudo:session): session closed for user root May 14 18:38:27 dac.x1 volumio[1133]: error: updateQueue error: null May 14 18:38:27 dac.x1 kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE May 14 18:38:27 dac.x1 kernel: CIFS: VFS: \\192.168.3.31 Send error in SessSetup = -13 May 14 18:38:27 dac.x1 kernel: CIFS: VFS: cifs_mount failed w/return code = -13 May 14 18:38:27 dac.x1 volumio[1133]: info: Cannot mount NAS Volumio at system boot, trial number 2 ,retrying in 5 seconds May 14 18:38:27 dac.x1 volumio[1493]: Generating RSA private key, 4096 bit long modulus (2 primes) May 14 18:38:28 dac.x1 kernel: broken atomic modeset userspace detected, disabling atomic May 14 18:38:28 dac.x1 startx[1422]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. May 14 18:38:28 dac.x1 volumio[1133]: info: go-librespot daemon successfully initialized May 14 18:38:29 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:29 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:29 dac.x1 volumio[1133]: info: touch_display: Setting screensaver timeout to 600 seconds. May 14 18:38:30 dac.x1 volumio[1133]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 14 18:38:31 dac.x1 sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 14 18:38:31 dac.x1 sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:31 dac.x1 sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 14 18:38:31 dac.x1 sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:31 dac.x1 sudo[1595]: pam_unix(sudo:session): session closed for user root May 14 18:38:31 dac.x1 sudo[1593]: pam_unix(sudo:session): session closed for user root May 14 18:38:31 dac.x1 volumio[1133]: verbose: New Socket.io Connection to 192.168.3.10 from 192.168.3.4 UA: Mozilla/5.0 (Linux; Android 14; Nokia XR20 Build/UKQ1.231003.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.113 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 14 18:38:31 dac.x1 volumio[1133]: info: Initializing connection to go-librespot Websocket May 14 18:38:32 dac.x1 volumio[1133]: info: Connection to go-librespot Websocket established May 14 18:38:32 dac.x1 go-librespot[1424]: time="2025-05-14T18:38:32+08:00" level=debug msg="new websocket client" May 14 18:38:32 dac.x1 sudo[1599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 14 18:38:32 dac.x1 sudo[1599]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:32 dac.x1 sudo[1599]: pam_unix(sudo:session): session closed for user root May 14 18:38:32 dac.x1 sudo[1601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 14 18:38:32 dac.x1 sudo[1601]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:32 dac.x1 sudo[1601]: pam_unix(sudo:session): session closed for user root May 14 18:38:32 dac.x1 volumio[1133]: verbose: New Socket.io Connection to 192.168.3.10 from 192.168.3.4 UA: Mozilla/5.0 (Linux; Android 14; Nokia XR20 Build/UKQ1.231003.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.113 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 14 18:38:32 dac.x1 sudo[1605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Volumio,password=#music#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.31/Volumio /mnt/NAS/Volumio May 14 18:38:32 dac.x1 sudo[1605]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:32 dac.x1 kernel: CIFS: Attempting to mount //192.168.3.31/Volumio May 14 18:38:32 dac.x1 sudo[1605]: pam_unix(sudo:session): session closed for user root May 14 18:38:32 dac.x1 kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE May 14 18:38:32 dac.x1 kernel: CIFS: VFS: \\192.168.3.31 Send error in SessSetup = -13 May 14 18:38:32 dac.x1 kernel: CIFS: VFS: cifs_mount failed w/return code = -13 May 14 18:38:32 dac.x1 volumio[1133]: info: Cannot mount NAS Volumio at system boot, trial number 3 ,retrying in 5 seconds May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetVisibleSources May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:33 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 14 18:38:33 dac.x1 volumio[1133]: info: Received Get System Info May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 14 18:38:33 dac.x1 volumio[1133]: info: Discovery: Getting this device information May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:33 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:33 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:33 dac.x1 volumio[1133]: info: Listing playlists May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 14 18:38:33 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 14 18:38:33 dac.x1 volumio[1133]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Wet%20Wet%20Wet/End%20Of%20Part%20One.%20Their%20Greatest%20Hits/ec0204a1-f236-435e-b5fd-f22be443503f.jpg' May 14 18:38:34 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 14 18:38:34 dac.x1 volumio[1133]: info: Received Get System Info May 14 18:38:34 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 14 18:38:34 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 14 18:38:34 dac.x1 volumio[1133]: info: Discovery: Getting this device information May 14 18:38:34 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:34 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:34 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 18:38:35 dac.x1 volumio[1133]: info: Getting Spotify volume May 14 18:38:35 dac.x1 volumio[1133]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 14 18:38:35 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:35 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:35 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 14 18:38:35 dac.x1 volumio[1133]: info: Adding plugin bluetooth to MyMusic Plugins May 14 18:38:35 dac.x1 volumio[1133]: info: Adding plugin multiroom to MyMusic Plugins May 14 18:38:35 dac.x1 volumio[1133]: info: Adding plugin metavolumio to MyMusic Plugins May 14 18:38:35 dac.x1 volumio[1133]: info: Adding plugin cd_controller to MyMusic Plugins May 14 18:38:35 dac.x1 volumio[1133]: info: Adding plugin smart_inputs to MyMusic Plugins May 14 18:38:35 dac.x1 volumio[1133]: info: Adding plugin tidalconnect to MyMusic Plugins May 14 18:38:35 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 14 18:38:35 dac.x1 wpa_supplicant[853]: wlan0: Failed to initiate sched scan May 14 18:38:36 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 14 18:38:36 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 14 18:38:36 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:36 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 14 18:38:36 dac.x1 volumio[1133]: info: Starting MyVolumio Remote Streaming Endpoints May 14 18:38:36 dac.x1 volumio[1133]: info: MyVolumio login type: Token May 14 18:38:36 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 14 18:38:36 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 14 18:38:38 dac.x1 volumio[1493]: .....................................................................................++++ May 14 18:38:38 dac.x1 volumio[1133]: info: Starting Streaming Service Transparent Proxy May 14 18:38:38 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 14 18:38:38 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 14 18:38:38 dac.x1 volumio[1133]: info: Streaming services startup May 14 18:38:38 dac.x1 volumio[1133]: info: Starting Streaming Daemon May 14 18:38:38 dac.x1 volumio[1133]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 14 18:38:38 dac.x1 sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 14 18:38:38 dac.x1 sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:38 dac.x1 sudo[1680]: pam_unix(sudo:session): session closed for user root May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::getUIConfigOnPlugin May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::getUIConfigOnPlugin May 14 18:38:39 dac.x1 volumio[1133]: info: Retrieving Cloud Streaming UI May 14 18:38:39 dac.x1 sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Volumio,password=#music#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.31/Volumio /mnt/NAS/Volumio May 14 18:38:39 dac.x1 sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0) May 14 18:38:39 dac.x1 volumio[1133]: error: Cannot start Volumio Streaming Daemon May 14 18:38:39 dac.x1 volumio[1133]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 14 18:38:39 dac.x1 volumio[1133]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 14 18:38:39 dac.x1 kernel: CIFS: Attempting to mount //192.168.3.31/Volumio May 14 18:38:39 dac.x1 sudo[1704]: pam_unix(sudo:session): session closed for user root May 14 18:38:39 dac.x1 kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE May 14 18:38:39 dac.x1 kernel: CIFS: VFS: \\192.168.3.31 Send error in SessSetup = -13 May 14 18:38:39 dac.x1 kernel: CIFS: VFS: cifs_mount failed w/return code = -13 May 14 18:38:39 dac.x1 volumio[1133]: info: Getting Tidal Cloud Configuration May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::getUIConfigOnPlugin May 14 18:38:39 dac.x1 volumio[1133]: info: Getting Qobuz Cloud Configuration May 14 18:38:39 dac.x1 volumio[1133]: info: Asking plugin for UI Config May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::getUIConfigOnPlugin May 14 18:38:39 dac.x1 volumio[1133]: info: Getting Spotify Cloud Configuration May 14 18:38:39 dac.x1 volumio[1133]: info: Asking plugin for UI Config May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::getUIConfigOnPlugin May 14 18:38:39 dac.x1 volumio[1133]: info: Saving Spotify Acccount May 14 18:38:39 dac.x1 volumio[1133]: info: Got Tidal Cloud Configuration May 14 18:38:39 dac.x1 volumio[1133]: info: Got it May 14 18:38:39 dac.x1 volumio[1133]: info: Got it May 14 18:38:39 dac.x1 volumio[1133]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 14 18:38:39 dac.x1 volumio[1133]: info: Cannot mount NAS Volumio at system boot, trial number 4 ,retrying in 5 seconds May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::getUIConfigOnPlugin May 14 18:38:39 dac.x1 volumio[1133]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetBrowseSources May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetBrowseSources May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetBrowseSources May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 14 18:38:39 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 14 18:38:40 dac.x1 volumio[1493]: ...............++++ May 14 18:38:40 dac.x1 volumio[1493]: e is 65537 (0x010001) May 14 18:38:40 dac.x1 volumio[1493]: writing RSA key May 14 18:38:40 dac.x1 volumio[1133]: STREAMING PROXY: Starting server on port 3245 May 14 18:38:40 dac.x1 volumio[1133]: Node JS runtime: 14 May 14 18:38:42 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 14 18:38:42 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 14 18:38:42 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 14 18:38:42 dac.x1 volumio[1133]: info: Discovery: Getting this device information May 14 18:38:42 dac.x1 volumio[1133]: info: CoreCommandRouter::volumioGetState May 14 18:38:42 dac.x1 volumio[1133]: info: CorePlayQueue::getTrack 0 May 14 18:38:42 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 14 18:38:43 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 14 18:38:43 dac.x1 volumio[1133]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 14 18:38:44 dac.x1 volumio[1133]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 May 14 18:38:44 dac.x1 volumio[1133]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 18:38:44 dac.x1 volumio[1133]: TypeError: Cannot read property 'replace' of undefined May 14 18:38:44 dac.x1 volumio[1133]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) May 14 18:38:44 dac.x1 volumio[1133]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) May 14 18:38:44 dac.x1 volumio[1133]: at listOnTimeout (internal/timers.js:554:17) May 14 18:38:44 dac.x1 volumio[1133]: at processTimers (internal/timers.js:497:7) May 14 18:38:44 dac.x1 volumio[1133]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 14 18:38:44 dac.x1 wpa_supplicant[853]: wlan0: Failed to initiate sched scan May 14 18:38:45 dac.x1 sudo[1863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-14 18:37 May 14 18:38:45 dac.x1 sudo[1863]: 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"