-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Tue 2025-03-18 16:33:44 MSK. -- Mar 18 16:32:56 volumiobatt systemd-timedated[1233]: Changed local time to Tue Mar 18 16:32:56 2025 Mar 18 16:32:56 volumiobatt volumio-time-update[848]: volumio-time-update-util: System time updated successfully. Mar 18 16:32:56 volumiobatt sudo[1230]: pam_unix(sudo:session): session closed for user root Mar 18 16:32:56 volumiobatt systemd[1]: Starting Daily man-db regeneration... Mar 18 16:32:56 volumiobatt systemd[1]: Starting Daily apt download activities... Mar 18 16:32:56 volumiobatt systemd[1]: Started Volumio Time Update Utility. Mar 18 16:32:56 volumiobatt systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 18 16:32:56 volumiobatt nmbd[988]: [2025/03/18 16:32:56.780074, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 18 16:32:56 volumiobatt nmbd[988]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 18 16:32:56 volumiobatt systemd[1]: Started Samba NMB Daemon. Mar 18 16:32:56 volumiobatt systemd[1]: Starting Samba Winbind Daemon... Mar 18 16:32:56 volumiobatt systemd[1]: man-db.service: Succeeded. Mar 18 16:32:56 volumiobatt systemd[1]: Started Daily man-db regeneration. Mar 18 16:32:56 volumiobatt winbindd[1274]: [2025/03/18 16:32:56.909379, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 18 16:32:56 volumiobatt winbindd[1274]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 18 16:32:56 volumiobatt winbindd[1274]: [2025/03/18 16:32:56.924855, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 18 16:32:56 volumiobatt systemd[1]: Started Samba Winbind Daemon. Mar 18 16:32:56 volumiobatt winbindd[1274]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 18 16:32:56 volumiobatt systemd[1]: Starting Samba SMB Daemon... Mar 18 16:32:56 volumiobatt volumio[1234]: info: ------------------------------------------- Mar 18 16:32:56 volumiobatt volumio[1234]: info: ----- Volumio3 ---- Mar 18 16:32:56 volumiobatt volumio[1234]: info: ------------------------------------------- Mar 18 16:32:56 volumiobatt volumio[1234]: info: ----- System startup ---- Mar 18 16:32:56 volumiobatt volumio[1234]: info: ------------------------------------------- Mar 18 16:32:57 volumiobatt systemd[1]: Started Samba SMB Daemon. Mar 18 16:32:57 volumiobatt smbd[1287]: [2025/03/18 16:32:57.106413, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 18 16:32:57 volumiobatt smbd[1287]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 18 16:32:57 volumiobatt systemd[1]: Reached target Multi-User System. Mar 18 16:32:57 volumiobatt systemd[1]: Reached target Graphical Interface. Mar 18 16:32:57 volumiobatt systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 18 16:32:57 volumiobatt systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 18 16:32:57 volumiobatt systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 18 16:32:57 volumiobatt systemd[1]: apt-daily.service: Succeeded. Mar 18 16:32:57 volumiobatt systemd[1]: Started Daily apt download activities. Mar 18 16:32:57 volumiobatt systemd[1]: Starting Daily apt upgrade and clean activities... Mar 18 16:32:57 volumiobatt volumio[1234]: info: MYVOLUMIO Environment detected Mar 18 16:32:57 volumiobatt volumio[1234]: info: Plugin folders cleanup Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning into folder /volumio/app/plugins/ Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning category audio_interface Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning category miscellanea Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning category music_service Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning category plugins.json Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning category system_controller Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning category user_interface Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning into folder /data/plugins/ Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning category music_service Mar 18 16:32:57 volumiobatt volumio[1234]: info: Scanning category user_interface Mar 18 16:32:57 volumiobatt volumio[1234]: info: Plugin folders cleanup completed Mar 18 16:32:57 volumiobatt volumio[1234]: info: ------------------------------------------- Mar 18 16:32:57 volumiobatt volumio[1234]: info: ----- Core plugins startup ---- Mar 18 16:32:57 volumiobatt volumio[1234]: info: ------------------------------------------- Mar 18 16:32:57 volumiobatt volumio[1234]: info: Loading plugins from folder /volumio/app/plugins/ Mar 18 16:32:57 volumiobatt volumio[1234]: info: Adding plugin upnp to MyMusic Plugins Mar 18 16:32:57 volumiobatt volumio[1234]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 18 16:32:57 volumiobatt volumio[1234]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 18 16:32:57 volumiobatt volumio[1234]: info: Loading plugins from folder /data/plugins/ Mar 18 16:32:57 volumiobatt volumio[1234]: info: Loading plugin "system"... Mar 18 16:32:57 volumiobatt volumio[1234]: info: Loading plugin "appearance"... Mar 18 16:32:57 volumiobatt volumio[1234]: info: Loading plugin "network"... Mar 18 16:32:57 volumiobatt volumio[1234]: info: Refreshing Cached IP Addresses Mar 18 16:32:57 volumiobatt sudo[1380]: volumio : unable to resolve host volumiobatt Mar 18 16:32:57 volumiobatt sudo[1380]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:32:57 volumiobatt sudo[1380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 18 16:32:57 volumiobatt sudo[1380]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:32:57 volumiobatt sudo[1380]: pam_unix(sudo:session): session closed for user root Mar 18 16:32:57 volumiobatt systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 18 16:32:57 volumiobatt sudo[1383]: volumio : unable to resolve host volumiobatt Mar 18 16:32:57 volumiobatt systemd[1]: Started Daily apt upgrade and clean activities. Mar 18 16:32:57 volumiobatt sudo[1383]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:32:57 volumiobatt sudo[1383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 18 16:32:57 volumiobatt sudo[1383]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:32:57 volumiobatt systemd[1]: Startup finished in 16.861s (kernel) + 24.086s (userspace) = 40.948s. Mar 18 16:32:57 volumiobatt sudo[1383]: pam_unix(sudo:session): session closed for user root Mar 18 16:32:57 volumiobatt volumio[1234]: info: Loading plugin "services"... Mar 18 16:32:57 volumiobatt volumio[1234]: info: Loading plugin "alsa_controller"... Mar 18 16:32:57 volumiobatt sudo[1393]: volumio : unable to resolve host volumiobatt Mar 18 16:32:57 volumiobatt sudo[1393]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:32:57 volumiobatt sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 18 16:32:57 volumiobatt sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:32:57 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 16:32:57 volumiobatt volumio[1234]: info: Loading plugin "wizard"... Mar 18 16:32:57 volumiobatt volumio[1234]: info: Loading plugin "networkfs"... Mar 18 16:32:57 volumiobatt volumio[1234]: info: Starting Udev Watcher for removable devices Mar 18 16:32:57 volumiobatt volumio[1234]: info: Mounting Device music Mar 18 16:32:57 volumiobatt sudo[1412]: volumio : unable to resolve host volumiobatt Mar 18 16:32:57 volumiobatt sudo[1417]: volumio : unable to resolve host volumiobatt Mar 18 16:32:57 volumiobatt sudo[1412]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:32:57 volumiobatt sudo[1417]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:32:57 volumiobatt sudo[1417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/music -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 18 16:32:57 volumiobatt sudo[1412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //volumio.synology.me/volume1/sbox /mnt/NAS/nas2 Mar 18 16:32:57 volumiobatt sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:32:57 volumiobatt sudo[1417]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:32:57 volumiobatt sudo[1410]: volumio : unable to resolve host volumiobatt Mar 18 16:32:57 volumiobatt sudo[1410]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:32:57 volumiobatt sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.2.101:/volume1/sbox /mnt/NAS/nas Mar 18 16:32:57 volumiobatt sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:32:58 volumiobatt ntfs-3g[1428]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 18 16:32:58 volumiobatt ntfs-3g[1428]: Mounted /dev/sda1 (Read-Write, label "music", NTFS 3.1) Mar 18 16:32:58 volumiobatt ntfs-3g[1428]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 18 16:32:58 volumiobatt ntfs-3g[1428]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 18 16:32:58 volumiobatt ntfs-3g[1428]: Global ownership and permissions enforced, configuration type 7 Mar 18 16:32:58 volumiobatt sudo[1417]: pam_unix(sudo:session): session closed for user root Mar 18 16:32:58 volumiobatt volumio[1234]: sudo: unable to resolve host volumiobatt: System error Mar 18 16:32:58 volumiobatt volumio[1234]: info: Ignoring mount for partition: boot Mar 18 16:32:58 volumiobatt volumio[1234]: info: Ignoring mount for partition: volumio Mar 18 16:32:58 volumiobatt volumio[1234]: info: Ignoring mount for partition: volumio_data Mar 18 16:32:58 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "volumio_command_line_client"... Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "upnp"... Mar 18 16:32:58 volumiobatt volumio[1234]: info: [1742304778116] Starting Upmpd Daemon Mar 18 16:32:58 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "my_music"... Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "mpd"... Mar 18 16:32:58 volumiobatt systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Mar 18 16:32:58 volumiobatt systemd[1]: Reached target Host and Network Name Lookups. Mar 18 16:32:58 volumiobatt systemd[1]: Starting Preprocess NFS configuration... Mar 18 16:32:58 volumiobatt systemd[1]: nfs-config.service: Succeeded. Mar 18 16:32:58 volumiobatt systemd[1]: Started Preprocess NFS configuration. Mar 18 16:32:58 volumiobatt systemd[1]: Starting Notify NFS peers of a restart... Mar 18 16:32:58 volumiobatt systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... Mar 18 16:32:58 volumiobatt sm-notify[1434]: Version 1.3.3 starting Mar 18 16:32:58 volumiobatt systemd[1]: rpc-statd-notify.service: Succeeded. Mar 18 16:32:58 volumiobatt systemd[1]: Started Notify NFS peers of a restart. Mar 18 16:32:58 volumiobatt rpc.statd[1437]: Version 1.3.3 starting Mar 18 16:32:58 volumiobatt rpc.statd[1437]: Flags: TI-RPC Mar 18 16:32:58 volumiobatt systemd[1]: Started NFS status monitor for NFSv2/3 locking.. Mar 18 16:32:58 volumiobatt kernel: Key type cifs.spnego registered Mar 18 16:32:58 volumiobatt kernel: Key type cifs.idmap registered Mar 18 16:32:58 volumiobatt 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 18 16:32:58 volumiobatt kernel: CIFS: Attempting to mount //volumio.synology.me/volume1/sbox Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "upnp_browser"... Mar 18 16:32:58 volumiobatt volumio-remote-updater[847]: [2025-03-18 16:32:58] [connect] Successful connection Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "alarm-clock"... Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "airplay_emulation"... Mar 18 16:32:58 volumiobatt volumio[1234]: info: Starting Shairport Sync Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "last_100"... Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "webradio"... Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "i2s_dacs"... Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "volumiodiscovery"... Mar 18 16:32:58 volumiobatt volumio[1234]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 18 16:32:58 volumiobatt node[1234]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 18 16:32:58 volumiobatt node[1234]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 18 16:32:58 volumiobatt volumio[1234]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 18 16:32:58 volumiobatt volumio[1234]: *** WARNING *** For more information see Mar 18 16:32:58 volumiobatt volumio[1234]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 18 16:32:58 volumiobatt volumio[1234]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 18 16:32:58 volumiobatt volumio[1234]: *** WARNING *** For more information see Mar 18 16:32:58 volumiobatt node[1234]: *** WARNING *** For more information see Mar 18 16:32:58 volumiobatt node[1234]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 18 16:32:58 volumiobatt node[1234]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 18 16:32:58 volumiobatt node[1234]: *** WARNING *** For more information see Mar 18 16:32:58 volumiobatt volumio[1234]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 18 16:32:58 volumiobatt volumio[1234]: info: Discovery: Started advertising with name: Volumio_batt Mar 18 16:32:58 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 18 16:32:58 volumiobatt volumio[1234]: info: Loading plugin "spop"... Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading plugin "peppy_screensaver"... Mar 18 16:32:59 volumiobatt volumio[1234]: info: Applying required configuration parameters for plugin peppy_screensaver Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading plugin "outputs"... Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading plugin "albumart"... Mar 18 16:32:59 volumiobatt volumio[1234]: info: Plugin example_plugin is not enabled Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading plugin "inputs"... Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading plugin "updater_comm"... Mar 18 16:32:59 volumiobatt volumio[1234]: info: Plugin mpdemulation is not enabled Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading plugin "rest_api"... Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading plugin "websocket"... Mar 18 16:32:59 volumiobatt volumio[1234]: info: Starting Socket.io Server version 2.3.0 Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading plugin "Systeminfo"... Mar 18 16:32:59 volumiobatt volumio[1234]: Forking 3 albumart workers Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading plugin "touch_display"... Mar 18 16:32:59 volumiobatt volumio[1234]: Starting albumart workers Mar 18 16:32:59 volumiobatt volumio[1234]: Starting albumart workers Mar 18 16:32:59 volumiobatt volumio[1234]: Starting albumart workers Mar 18 16:32:59 volumiobatt volumio[1234]: info: Applying required configuration parameters for plugin touch_display Mar 18 16:32:59 volumiobatt volumio[1234]: info: Loading i18n strings for locale ru Mar 18 16:32:59 volumiobatt volumio[1234]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 18 16:32:59 volumiobatt volumio[1234]: Updating browse sources language Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::initPlayerControls Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: Express server listening on port 3000 Mar 18 16:32:59 volumiobatt volumio[1234]: [Metrics] WebUI: 3s 223.99ms Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreStateMachine::resetVolumioState Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreStateMachine::getcurrentVolume Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioRetrievevolume Mar 18 16:32:59 volumiobatt volumio[1234]: info: Volumio Network Manager: Network status updated: 2 Mar 18 16:32:59 volumiobatt volumio-remote-updater[847]: [2025-03-18 16:32:59] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742304778 101 Mar 18 16:32:59 volumiobatt sudo[1410]: pam_unix(sudo:session): session closed for user root Mar 18 16:32:59 volumiobatt volumio[1234]: 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 Mar 18 16:32:59 volumiobatt volumio[1234]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 18 16:32:59 volumiobatt volumio[1234]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:32:59 volumiobatt volumio[1234]: info: Reloading queue from file Mar 18 16:32:59 volumiobatt volumio[1234]: info: VolumeController:: Volume=98 Mute =false Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreStateMachine::pushState Mar 18 16:32:59 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioPushState Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreStateMachine::updateTrackBlock Mar 18 16:32:59 volumiobatt volumio[1234]: info: CorePlayQueue::getTrackBlock Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioRetrievevolume Mar 18 16:32:59 volumiobatt volumio[1234]: info: Setting Device type: Raspberry PI Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreStateMachine::setRepeat null single undefined Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreStateMachine::pushState Mar 18 16:32:59 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioPushState Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreStateMachine::setRandom null Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreStateMachine::pushState Mar 18 16:32:59 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioPushState Mar 18 16:32:59 volumiobatt volumio[1234]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 18 16:32:59 volumiobatt volumio[1234]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Mar 18 16:32:59 volumiobatt volumio[1234]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 18 16:32:59 volumiobatt volumio[1234]: info: VolumeController:: Volume=98 Mute =false Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreStateMachine::pushState Mar 18 16:32:59 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:32:59 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioPushState Mar 18 16:33:01 volumiobatt sudo[1393]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:01 volumiobatt volumio[1234]: info: Discovery: adding 135c5eb0-0a88-475c-bcbb-2c3aa777f15e Mar 18 16:33:01 volumiobatt volumio[1234]: info: Discovery: Found device Volumio_batt Mar 18 16:33:01 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:01 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:05 volumiobatt systemd[1]: systemd-fsckd.service: Succeeded. Mar 18 16:33:05 volumiobatt sh[760]: timed out Mar 18 16:33:05 volumiobatt dhcpcd[820]: timed out Mar 18 16:33:05 volumiobatt sh[760]: dhcpcd exited Mar 18 16:33:05 volumiobatt dhcpcd[820]: dhcpcd exited Mar 18 16:33:05 volumiobatt sh[760]: ifup: failed to bring up eth0 Mar 18 16:33:05 volumiobatt systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 18 16:33:05 volumiobatt systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 18 16:33:06 volumiobatt systemd[1]: systemd-hostnamed.service: Succeeded. Mar 18 16:33:08 volumiobatt sudo[1536]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1536]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 18 16:33:08 volumiobatt sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1536]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:08 volumiobatt sudo[1538]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1538]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 18 16:33:08 volumiobatt sudo[1538]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1538]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:08 volumiobatt sudo[1541]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1541]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 18 16:33:08 volumiobatt sudo[1541]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt systemd[1]: Started UPnP Renderer front-end to MPD. Mar 18 16:33:08 volumiobatt sudo[1541]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:08 volumiobatt volumio[1234]: info: Upmpdcli Daemon Started Mar 18 16:33:08 volumiobatt volumio[1544]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 18 16:33:08 volumiobatt sudo[1412]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:08 volumiobatt kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Mar 18 16:33:08 volumiobatt kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Mar 18 16:33:08 volumiobatt volumio[1234]: info: Cannot mount NAS nas2 at system boot, trial number 1 ,retrying in 5 seconds Mar 18 16:33:08 volumiobatt volumio[1234]: info: Completed loading Core Plugins Mar 18 16:33:08 volumiobatt volumio[1234]: info: Preparing to generate the ALSA configuration file Mar 18 16:33:08 volumiobatt volumio[1234]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Mar 18 16:33:08 volumiobatt volumio[1234]: info: Reading ALSA contributions from plugins. Mar 18 16:33:08 volumiobatt volumio[1234]: info: Asound.conf file unchanged, so no further update is needed Mar 18 16:33:08 volumiobatt volumio[1234]: info: Output device has changed, restarting MPD Mar 18 16:33:08 volumiobatt volumio[1234]: info: Output device has changed, restarting Shairport Sync Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:08 volumiobatt sudo[1561]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1561]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 18 16:33:08 volumiobatt sudo[1561]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1563]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1563]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 18 16:33:08 volumiobatt sudo[1563]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1561]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:08 volumiobatt systemd[1]: Stopping Music Player Daemon... Mar 18 16:33:08 volumiobatt volumio[1234]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 18 16:33:08 volumiobatt volumio[1234]: info: ___________ START PLUGINS ___________ Mar 18 16:33:08 volumiobatt volumio[1234]: info: ControllerMpd::onStart: Initializing MPD Mar 18 16:33:08 volumiobatt volumio[1234]: info: Creating MPD Configuration file Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 18 16:33:08 volumiobatt sudo[1570]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1570]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt volumio[1234]: info: [1742304788605] CoreMusicLibrary::Adding element Медиа-серверы Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 16:33:08 volumiobatt sudo[1570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 18 16:33:08 volumiobatt sudo[1570]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1570]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:08 volumiobatt sudo[1572]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1572]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:08 volumiobatt sudo[1572]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt volumio[1234]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 18 16:33:08 volumiobatt volumio[1234]: info: [1742304788644] CoreMusicLibrary::Adding element Last_100 Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 18 16:33:08 volumiobatt volumio[1234]: info: [1742304788646] CoreMusicLibrary::Adding element Webradio Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 16:33:08 volumiobatt systemd[1]: mpd.service: Succeeded. Mar 18 16:33:08 volumiobatt systemd[1]: Stopped Music Player Daemon. Mar 18 16:33:08 volumiobatt volumio[1234]: info: Initializing BBC Radios Mar 18 16:33:08 volumiobatt systemd[1]: Starting Music Player Daemon... Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: Creating Spotify config file Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt sudo[1581]: root : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1581]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1581]: sudo: unable to resolve host volumiobatt: System error Mar 18 16:33:08 volumiobatt sudo[1581]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 18 16:33:08 volumiobatt sudo[1581]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1581]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:08 volumiobatt volumio[1234]: info: Loading i18n strings for locale ru Mar 18 16:33:08 volumiobatt volumio[1234]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 18 16:33:08 volumiobatt volumio[1234]: info: /tmp/myfifo created Mar 18 16:33:08 volumiobatt volumio[1234]: info: /tmp/myfifosa created Mar 18 16:33:08 volumiobatt sudo[1599]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1599]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Mar 18 16:33:08 volumiobatt sudo[1599]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1599]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:08 volumiobatt volumio[1234]: sudo: unable to resolve host volumiobatt: System error Mar 18 16:33:08 volumiobatt volumio[1234]: info: snd-dummy loaded Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 18 16:33:08 volumiobatt volumio[1234]: info: Loading i18n strings for locale ru Mar 18 16:33:08 volumiobatt volumio[1234]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 16:33:08 volumiobatt volumio[1234]: info: Volumio Calling Home Mar 18 16:33:08 volumiobatt sudo[1621]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1621]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Mar 18 16:33:08 volumiobatt sudo[1621]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1623]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1623]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Mar 18 16:33:08 volumiobatt sudo[1623]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1626]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1626]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt sudo[1626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 18 16:33:08 volumiobatt sudo[1626]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt sudo[1621]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:08 volumiobatt volumio[1234]: info: touch_display: No backlight interface detected. Mar 18 16:33:08 volumiobatt systemd[1]: Reloading. Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:08 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:08 volumiobatt volumio[1234]: info: MPD Permissions set Mar 18 16:33:08 volumiobatt volumio[1234]: info: MPD Permissions set Mar 18 16:33:08 volumiobatt volumio[1234]: info: touch_display: systemctl stop getty@tty1.service succeeded. Mar 18 16:33:08 volumiobatt volumio[1234]: info: Spotify config file written Mar 18 16:33:08 volumiobatt mpd[1593]: Mar 18 16:33 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 18 16:33:08 volumiobatt sudo[1630]: volumio : unable to resolve host volumiobatt Mar 18 16:33:08 volumiobatt sudo[1630]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:08 volumiobatt volumio[1234]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 18 16:33:08 volumiobatt sudo[1630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Mar 18 16:33:08 volumiobatt sudo[1630]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:08 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: No need to fix Spotify hosts Mar 18 16:33:09 volumiobatt 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. Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Mar 18 16:33:09 volumiobatt sudo[1659]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1659]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Mar 18 16:33:09 volumiobatt sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt volumio[1234]: info: Starting Shairport Sync Mar 18 16:33:09 volumiobatt sudo[1659]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt sudo[1661]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1661]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Mar 18 16:33:09 volumiobatt sudo[1661]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt volumio[1234]: info: Starting Shairport Sync Mar 18 16:33:09 volumiobatt sudo[1666]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1666]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 18 16:33:09 volumiobatt sudo[1666]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt sudo[1661]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt sudo[1664]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1664]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Mar 18 16:33:09 volumiobatt sudo[1664]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt volumio[1234]: info: Starting Shairport Sync Mar 18 16:33:09 volumiobatt volumio[1234]: info: Starting Shairport Sync Mar 18 16:33:09 volumiobatt sudo[1664]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt sudo[1671]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1671]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 18 16:33:09 volumiobatt sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt sudo[1673]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1673]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 18 16:33:09 volumiobatt sudo[1673]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:09 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:09 volumiobatt sudo[1676]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1676]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 18 16:33:09 volumiobatt sudo[1676]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Mar 18 16:33:09 volumiobatt systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. Mar 18 16:33:09 volumiobatt volumio[1234]: info: Volumio called home Mar 18 16:33:09 volumiobatt systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt sudo[1680]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1680]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:09 volumiobatt volumio[1234]: info: MPD Permissions set Mar 18 16:33:09 volumiobatt sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 18 16:33:09 volumiobatt sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt sudo[1680]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt volumio[1234]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 18 16:33:09 volumiobatt volumio[1234]: SPOTIFY: BQDU0iPEJYWKssqlUwU2bdLy1V60sockODipgd-TU0JPoQn1v0X9PNKle4NcNg-OJa5awqHbCZ9XJ3idlz4oZMZkdNKc8JcbJ7_WwqIsx9aa_ORhIi4xBhYA6QXpbC0RUGDcD6Q8BbNGlgQPrrZ0LEgafYWO5ODs_mQ6uqpEyFX6VSd9ARNIoK4AagIGnSbP7pY3f3K5EA-HXy2feLqrqv0uQmKc74_oCaJBMrj73MIuO9gcKbjbz8Nm5yBnpRBHr5qIKJ2nTN52nMtXxYfo0V-FMBQiAxU4OkYDUwwYM80 Mar 18 16:33:09 volumiobatt volumio[1234]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Mar 18 16:33:09 volumiobatt volumio[1234]: info: New Spotify access token = BQDU0iPEJYWKssqlUwU2bdLy1V60sockODipgd-TU0JPoQn1v0X9PNKle4NcNg-OJa5awqHbCZ9XJ3idlz4oZMZkdNKc8JcbJ7_WwqIsx9aa_ORhIi4xBhYA6QXpbC0RUGDcD6Q8BbNGlgQPrrZ0LEgafYWO5ODs_mQ6uqpEyFX6VSd9ARNIoK4AagIGnSbP7pY3f3K5EA-HXy2feLqrqv0uQmKc74_oCaJBMrj73MIuO9gcKbjbz8Nm5yBnpRBHr5qIKJ2nTN52nMtXxYfo0V-FMBQiAxU4OkYDUwwYM80 Mar 18 16:33:09 volumiobatt volumio[1234]: info: Spotify credentials grant success - running version from March 24, 2019 Mar 18 16:33:09 volumiobatt sudo[1626]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt systemd[1]: Started Music Player Daemon. Mar 18 16:33:09 volumiobatt sudo[1572]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt sudo[1563]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt systemd[1]: Reloading. Mar 18 16:33:09 volumiobatt volumio[1234]: error: updateQueue error: null Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: systemctl daemon-reload succeeded. Mar 18 16:33:09 volumiobatt volumio[1234]: info: MPD running with PID1593 Mar 18 16:33:09 volumiobatt volumio[1234]: ,establishing connection Mar 18 16:33:09 volumiobatt volumio[1234]: error: updateQueue error: null Mar 18 16:33:09 volumiobatt volumio[1234]: error: updateQueue error: null Mar 18 16:33:09 volumiobatt sudo[1689]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1689]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Mar 18 16:33:09 volumiobatt sudo[1689]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt 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. Mar 18 16:33:09 volumiobatt volumio[1234]: error: Failed to retrieve user informations: WebapiRegularError: An error occurred while communicating with Spotify's Web API. Mar 18 16:33:09 volumiobatt volumio[1234]: Details: Spotify is unavailable in this country. Mar 18 16:33:09 volumiobatt volumio[1234]: error: Spotify credentials failed to read user data: Mar 18 16:33:09 volumiobatt volumio[1234]: info: An error occurred while initializing Spotify Browsing facility: Mar 18 16:33:09 volumiobatt systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Mar 18 16:33:09 volumiobatt sudo[1623]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: systemctl disable getty@tty1.service succeeded. Mar 18 16:33:09 volumiobatt systemd[1]: Started Volumio Kiosk. Mar 18 16:33:09 volumiobatt systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 18 16:33:09 volumiobatt sudo[1689]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt systemd[1]: Started go-librespot Daemon. Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: Volumio Kiosk started. Mar 18 16:33:09 volumiobatt sudo[1630]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt systemd[1]: shairport-sync.service: Succeeded. Mar 18 16:33:09 volumiobatt go-librespot[1705]: go-librespot daemon starting... Mar 18 16:33:09 volumiobatt systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:09 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:09 volumiobatt systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 18 16:33:09 volumiobatt sudo[1666]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt volumio[1234]: info: Completed starting Core Plugins Mar 18 16:33:09 volumiobatt volumio[1234]: info: ------------------------------------------- Mar 18 16:33:09 volumiobatt volumio[1234]: info: ----- MyVolumio plugins startup ---- Mar 18 16:33:09 volumiobatt volumio[1234]: info: ------------------------------------------- Mar 18 16:33:09 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 18 16:33:09 volumiobatt sudo[1673]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt sudo[1676]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt sudo[1671]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt startx[1704]: hostname: System error Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:09 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:09 volumiobatt volumio[1234]: info: Shairport-Sync Started Mar 18 16:33:09 volumiobatt volumio[1234]: Error adding Membership: Error: addMembership EINVAL Mar 18 16:33:09 volumiobatt volumio[1234]: info: Shairport-Sync Started Mar 18 16:33:09 volumiobatt volumio[1234]: info: Shairport-Sync Started Mar 18 16:33:09 volumiobatt volumio[1234]: info: Shairport-Sync Started Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: X display number found: Mar 18 16:33:09 volumiobatt startx[1704]: xauth: (stdin):1: bad display name "volumiobatt:0" in "add" command Mar 18 16:33:09 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Mar 18 16:33:09 volumiobatt startx[1704]: X.Org X Server 1.20.4 Mar 18 16:33:09 volumiobatt startx[1704]: X Protocol Version 11, Revision 0 Mar 18 16:33:09 volumiobatt startx[1704]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Mar 18 16:33:09 volumiobatt startx[1704]: Current Operating System: Linux volumiobatt 6.6.62-v8+ #1816 SMP PREEMPT Mon Nov 18 15:35:52 GMT 2024 aarch64 Mar 18 16:33:09 volumiobatt startx[1704]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave smsc95xx.macaddr=2C:CF:67:81:27:A7 vc_mem.mem_base=0x3fc00000 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=ttyAMA10,115200 console=tty1 imgpart=UUID=a0ee35d1-02bc-4547-b2c7-e6caa39d3454 imgfile=/volumio_current.sqsh bootpart=UUID=1BFB-AD60 datapart=UUID=a3c1e1ba-b424-4a77-8c81-c20d638e72d6 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 Mar 18 16:33:09 volumiobatt startx[1704]: Build Date: 04 April 2023 07:50:56AM Mar 18 16:33:09 volumiobatt startx[1704]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Mar 18 16:33:09 volumiobatt startx[1704]: Current version of pixman: 0.36.0 Mar 18 16:33:09 volumiobatt startx[1704]: Before reporting problems, check http://wiki.x.org Mar 18 16:33:09 volumiobatt startx[1704]: to make sure that you have the latest version. Mar 18 16:33:09 volumiobatt startx[1704]: Markers: (--) probed, (**) from config file, (==) default setting, Mar 18 16:33:09 volumiobatt startx[1704]: (++) from command line, (!!) notice, (II) informational, Mar 18 16:33:09 volumiobatt startx[1704]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Mar 18 16:33:09 volumiobatt startx[1704]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Mar 18 16:33:09 2025 Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: X display number found: 0 Mar 18 16:33:09 volumiobatt startx[1704]: (==) Using config directory: "/etc/X11/xorg.conf.d" Mar 18 16:33:09 volumiobatt startx[1704]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Mar 18 16:33:09 volumiobatt sudo[1744]: volumio : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1744]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 18 16:33:09 volumiobatt sudo[1744]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt systemd[1]: Stopping Music Player Daemon... Mar 18 16:33:09 volumiobatt systemd[1]: mpd.service: Succeeded. Mar 18 16:33:09 volumiobatt systemd[1]: Stopped Music Player Daemon. Mar 18 16:33:09 volumiobatt systemd[1]: Starting Music Player Daemon... Mar 18 16:33:09 volumiobatt go-librespot[1705]: time="2025-03-18T16:33:09+03:00" level=info msg="running go-librespot 0.2.0" Mar 18 16:33:09 volumiobatt go-librespot[1705]: time="2025-03-18T16:33:09+03:00" level=debug msg="app state loaded" Mar 18 16:33:09 volumiobatt go-librespot[1705]: time="2025-03-18T16:33:09+03:00" level=debug msg="stored credentials not found" Mar 18 16:33:09 volumiobatt go-librespot[1705]: time="2025-03-18T16:33:09+03:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 18 16:33:09 volumiobatt sudo[1746]: root : unable to resolve host volumiobatt Mar 18 16:33:09 volumiobatt sudo[1746]: sudo: unable to resolve host volumiobatt: System error Mar 18 16:33:09 volumiobatt sudo[1746]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:09 volumiobatt sudo[1746]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 18 16:33:09 volumiobatt sudo[1746]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:09 volumiobatt sudo[1746]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Mar 18 16:33:09 volumiobatt volumio[1234]: info: touch_display: X display number found: 0 Mar 18 16:33:09 volumiobatt go-librespot[1705]: time="2025-03-18T16:33:09+03:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Mar 18 16:33:09 volumiobatt go-librespot[1705]: time="2025-03-18T16:33:09+03:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 18 16:33:09 volumiobatt go-librespot[1705]: time="2025-03-18T16:33:09+03:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 18 16:33:09 volumiobatt go-librespot[1705]: time="2025-03-18T16:33:09+03:00" level=info msg="zeroconf server listening on port 45935" Mar 18 16:33:09 volumiobatt mpd[1748]: Mar 18 16:33 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 18 16:33:09 volumiobatt systemd[1]: Started Music Player Daemon. Mar 18 16:33:09 volumiobatt sudo[1744]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:09 volumiobatt volumio[1234]: error: updateQueue error: null Mar 18 16:33:10 volumiobatt startx[1704]: V3D 7.1 not supported by this version of Mesa. Mar 18 16:33:10 volumiobatt kernel: broken atomic modeset userspace detected, disabling atomic Mar 18 16:33:10 volumiobatt startx[1704]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. Mar 18 16:33:11 volumiobatt volumio[1234]: info: touch_display: Setting screensaver timeout to 300000 seconds. Mar 18 16:33:12 volumiobatt volumio[1234]: info: go-librespot daemon successfully initialized Mar 18 16:33:13 volumiobatt sudo[1906]: volumio : unable to resolve host volumiobatt Mar 18 16:33:13 volumiobatt sudo[1906]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:13 volumiobatt sudo[1906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //volumio.synology.me/volume1/sbox /mnt/NAS/nas2 Mar 18 16:33:13 volumiobatt sudo[1906]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:13 volumiobatt kernel: CIFS: Attempting to mount //volumio.synology.me/volume1/sbox Mar 18 16:33:13 volumiobatt volumio[1544]: .................................................................................................................++++ Mar 18 16:33:14 volumiobatt volumio[1544]: .................++++ Mar 18 16:33:14 volumiobatt volumio[1544]: e is 65537 (0x010001) Mar 18 16:33:14 volumiobatt volumio[1544]: writing RSA key Mar 18 16:33:15 volumiobatt volumio[1234]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 18 16:33:15 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 18 16:33:15 volumiobatt volumio[1234]: info: Initializing connection to go-librespot Websocket Mar 18 16:33:15 volumiobatt volumio[1234]: info: Connection to go-librespot Websocket established Mar 18 16:33:15 volumiobatt go-librespot[1705]: time="2025-03-18T16:33:15+03:00" level=debug msg="new websocket client" Mar 18 16:33:15 volumiobatt volumio[1234]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Mar 18 16:33:15 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetVisibleSources Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:16 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 18 16:33:16 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:16 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:16 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:16 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:16 volumiobatt volumio[1234]: info: Listing playlists Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 18 16:33:16 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:16 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:17 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 18 16:33:17 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:17 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:17 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:17 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:17 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:17 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:17 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:17 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 18 16:33:17 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 18 16:33:18 volumiobatt volumio[1234]: info: Adding plugin bluetooth to MyMusic Plugins Mar 18 16:33:18 volumiobatt volumio[1234]: info: Adding plugin multiroom to MyMusic Plugins Mar 18 16:33:18 volumiobatt volumio[1234]: info: Adding plugin metavolumio to MyMusic Plugins Mar 18 16:33:18 volumiobatt volumio[1234]: info: Adding plugin cd_controller to MyMusic Plugins Mar 18 16:33:18 volumiobatt volumio[1234]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 18 16:33:18 volumiobatt volumio[1234]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 18 16:33:18 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 18 16:33:18 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 18 16:33:18 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 18 16:33:18 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:18 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:18 volumiobatt volumio[1234]: info: Starting MyVolumio Remote Streaming Endpoints Mar 18 16:33:18 volumiobatt volumio[1234]: info: MyVolumio login type: Token Mar 18 16:33:18 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 18 16:33:18 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 18 16:33:18 volumiobatt volumio[1234]: info: Starting Streaming Service Transparent Proxy Mar 18 16:33:18 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 18 16:33:18 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 18 16:33:18 volumiobatt volumio[1234]: info: Streaming services startup Mar 18 16:33:18 volumiobatt volumio[1234]: info: Starting Streaming Daemon Mar 18 16:33:18 volumiobatt sudo[2202]: volumio : unable to resolve host volumiobatt Mar 18 16:33:18 volumiobatt sudo[2202]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:18 volumiobatt sudo[2202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 18 16:33:18 volumiobatt sudo[2202]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:18 volumiobatt volumio[1234]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 18 16:33:18 volumiobatt sudo[2202]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:18 volumiobatt volumio[1234]: info: Getting Spotify volume Mar 18 16:33:18 volumiobatt volumio[1234]: error: Cannot start Volumio Streaming Daemon Mar 18 16:33:18 volumiobatt volumio[1234]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 18 16:33:18 volumiobatt volumio[1234]: sudo: unable to resolve host volumiobatt: System error Mar 18 16:33:18 volumiobatt volumio[1234]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 18 16:33:18 volumiobatt volumio[1234]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 18 16:33:18 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:18 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:18 volumiobatt volumio[1234]: SPOTIFY: RECEIVED VOLUMIO VOLUME 98 Mar 18 16:33:18 volumiobatt volumio[1234]: SPOTIFY: SPOTIFY VOLUME undefined Mar 18 16:33:18 volumiobatt volumio[1234]: SPOTIFY: VOLUMIO VOLUME 98 Mar 18 16:33:18 volumiobatt volumio[1234]: info: Aligning Spotify Volume to Volumio Volume Mar 18 16:33:18 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:18 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:18 volumiobatt volumio[1234]: info: Setting Spotify Volume from Volumio: 98 Mar 18 16:33:18 volumiobatt volumio[1234]: STREAMING PROXY: Starting server on port 3245 Mar 18 16:33:18 volumiobatt volumio[1234]: Node JS runtime: 14 Mar 18 16:33:18 volumiobatt volumio[1234]: error: MyVolumio Custom Token format not valid, refreshing it Mar 18 16:33:19 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 18 16:33:19 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:19 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:19 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:19 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:19 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:19 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:19 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:19 volumiobatt volumio[1234]: info: MyVolumio login type: Token Mar 18 16:33:20 volumiobatt volumio[1234]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 18 16:33:20 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 18 16:33:20 volumiobatt volumio[1234]: info: MyVolumio login type: Token Mar 18 16:33:20 volumiobatt volumio[1234]: SPOTIFY: SETTING SPOTIFY VOLUME 98 Mar 18 16:33:20 volumiobatt volumio[1234]: info: Sending Spotify command with payload to local API: /player/volume Mar 18 16:33:20 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 18 16:33:20 volumiobatt volumio[1234]: info: MyVolumio login type: Token Mar 18 16:33:21 volumiobatt volumio[1234]: info: MyVolumio token set successfully Mar 18 16:33:21 volumiobatt volumio[1234]: info: MYVOLUMIO: Adding device Mar 18 16:33:21 volumiobatt volumio[1234]: info: MYVOLUMIO: Evaluating Server Mar 18 16:33:21 volumiobatt sudo[2212]: volumio : unable to resolve host volumiobatt Mar 18 16:33:21 volumiobatt sudo[2212]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:21 volumiobatt sudo[2212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 18 16:33:21 volumiobatt sudo[2212]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:21 volumiobatt sudo[2214]: volumio : unable to resolve host volumiobatt Mar 18 16:33:21 volumiobatt sudo[2214]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:21 volumiobatt sudo[2214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 18 16:33:21 volumiobatt sudo[2212]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:21 volumiobatt sudo[2214]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:21 volumiobatt sudo[2214]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:21 volumiobatt volumio[1234]: verbose: New Socket.io Connection to 192.168.2.66 from 192.168.2.96 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/134.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Mar 18 16:33:21 volumiobatt volumio[1234]: info: MyVolumio status changed Mar 18 16:33:21 volumiobatt volumio[1234]: info: Streaming services startup Mar 18 16:33:21 volumiobatt volumio[1234]: info: Starting Streaming Daemon Mar 18 16:33:21 volumiobatt volumio[1234]: info: Removing browser output: myVolumio user plan is not superstar Mar 18 16:33:21 volumiobatt volumio[1234]: info: Removing audio output: Mar 18 16:33:21 volumiobatt volumio[1234]: info: Stoppping Tunnel 1 Mar 18 16:33:21 volumiobatt sudo[2233]: volumio : unable to resolve host volumiobatt Mar 18 16:33:21 volumiobatt sudo[2233]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:21 volumiobatt sudo[2233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 18 16:33:21 volumiobatt sudo[2233]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 18 16:33:21 volumiobatt sudo[2235]: volumio : unable to resolve host volumiobatt Mar 18 16:33:21 volumiobatt sudo[2235]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:21 volumiobatt sudo[2235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 18 16:33:21 volumiobatt sudo[2235]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:21 volumiobatt sudo[2233]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:21 volumiobatt volumio[1234]: error: Cannot start Volumio Streaming Daemon Mar 18 16:33:21 volumiobatt volumio[1234]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 18 16:33:21 volumiobatt volumio[1234]: sudo: unable to resolve host volumiobatt: System error Mar 18 16:33:21 volumiobatt volumio[1234]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 18 16:33:21 volumiobatt sudo[2235]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:21 volumiobatt volumio[1234]: info: Remote SSH Stopped Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetVisibleSources Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:21 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetQueue Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreStateMachine::getQueue Mar 18 16:33:21 volumiobatt volumio[1234]: info: CorePlayQueue::getQueue Mar 18 16:33:21 volumiobatt volumio[1234]: info: Listing playlists Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 18 16:33:21 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:21 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:21 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:21 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 18 16:33:21 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 18 16:33:22 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 18 16:33:22 volumiobatt volumio[1234]: info: Setting Geolocation for MyVolumio to eu7 Mar 18 16:33:22 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:22 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:22 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:22 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 18 16:33:22 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:22 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:22 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:22 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:22 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:22 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:22 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:23 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 18 16:33:23 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:23 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:23 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:23 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:23 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:23 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:23 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:23 volumiobatt volumio[1234]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 18 16:33:23 volumiobatt sudo[1906]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:23 volumiobatt kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Mar 18 16:33:23 volumiobatt kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Mar 18 16:33:24 volumiobatt volumio[1234]: info: Updating MyVolumio device info Mar 18 16:33:24 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:24 volumiobatt volumio[1234]: info: Cannot mount NAS nas2 at system boot, trial number 2 ,retrying in 5 seconds Mar 18 16:33:25 volumiobatt volumio[1234]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 18 16:33:25 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 18 16:33:26 volumiobatt systemd[1]: systemd-timedated.service: Succeeded. Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 18 16:33:26 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:26 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:26 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 18 16:33:26 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:26 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:26 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:26 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:26 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:27 volumiobatt volumio[1234]: info: MYVOLUMIO: Adding device Mar 18 16:33:27 volumiobatt volumio[1234]: info: MYVOLUMIO: Evaluating Server Mar 18 16:33:28 volumiobatt volumio[1234]: info: Setting Geolocation for MyVolumio to eu4 Mar 18 16:33:28 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:28 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 18 16:33:29 volumiobatt volumio[1234]: info: Updating MyVolumio device info Mar 18 16:33:29 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:29 volumiobatt sudo[2270]: volumio : unable to resolve host volumiobatt Mar 18 16:33:29 volumiobatt sudo[2270]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:29 volumiobatt sudo[2270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //volumio.synology.me/volume1/sbox /mnt/NAS/nas2 Mar 18 16:33:29 volumiobatt sudo[2270]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 18 16:33:29 volumiobatt kernel: CIFS: Attempting to mount //volumio.synology.me/volume1/sbox Mar 18 16:33:30 volumiobatt volumio[1234]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 18 16:33:30 volumiobatt volumio[1234]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 18 16:33:31 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 16:33:32 volumiobatt volumio[1234]: info: Retrieving Cloud Streaming UI Mar 18 16:33:32 volumiobatt volumio[1234]: info: Getting Tidal Cloud Configuration Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 16:33:32 volumiobatt volumio[1234]: info: Getting Qobuz Cloud Configuration Mar 18 16:33:32 volumiobatt volumio[1234]: info: Asking plugin for UI Config Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 16:33:32 volumiobatt volumio[1234]: info: Getting Spotify Cloud Configuration Mar 18 16:33:32 volumiobatt volumio[1234]: info: Asking plugin for UI Config Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 16:33:32 volumiobatt volumio[1234]: info: Saving Spotify Acccount Mar 18 16:33:32 volumiobatt volumio[1234]: info: Got Tidal Cloud Configuration Mar 18 16:33:32 volumiobatt volumio[1234]: info: Got it Mar 18 16:33:32 volumiobatt volumio[1234]: info: Got it Mar 18 16:33:32 volumiobatt volumio[1234]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 18 16:33:32 volumiobatt volumio[1234]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetBrowseSources Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetBrowseSources Mar 18 16:33:32 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetBrowseSources Mar 18 16:33:33 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 18 16:33:33 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 18 16:33:33 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 18 16:33:33 volumiobatt volumio[1234]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 18 16:33:33 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:33 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:34 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 18 16:33:34 volumiobatt volumio[1234]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 18 16:33:34 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 18 16:33:34 volumiobatt volumio[1234]: info: Received Get System Version Mar 18 16:33:34 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 16:33:34 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:34 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:34 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:34 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:34 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:34 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:34 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:36 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetBrowseSources Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 16:33:38 volumiobatt volumio[1234]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 18 16:33:38 volumiobatt volumio[1234]: info: Completed starting MyVolumio Plugin Mar 18 16:33:38 volumiobatt volumio[1234]: [Metrics] CommandRouter: 41s 700.50ms Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::volumiosetStartupVolume Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::Close All Modals sent Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::Close All Modals sent Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 18 16:33:38 volumiobatt volumio-remote-updater[847]: No test mode Mar 18 16:33:38 volumiobatt volumio-remote-updater[847]: No alpha test mode Mar 18 16:33:38 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 18 16:33:39 volumiobatt volumio[1234]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 18 16:33:39 volumiobatt sudo[2270]: pam_unix(sudo:session): session closed for user root Mar 18 16:33:39 volumiobatt volumio[1234]: info: Cannot mount NAS nas2 at system boot, trial number 3 ,retrying in 5 seconds Mar 18 16:33:39 volumiobatt kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Mar 18 16:33:39 volumiobatt kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 18 16:33:39 volumiobatt volumio[1234]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 18 16:33:39 volumiobatt volumio[1234]: info: Received Get System Version Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 18 16:33:39 volumiobatt volumio[1234]: info: Received Get System Info Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 18 16:33:39 volumiobatt volumio[1234]: info: Discovery: Getting this device information Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::volumioGetState Mar 18 16:33:39 volumiobatt volumio[1234]: info: CorePlayQueue::getTrack 0 Mar 18 16:33:39 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 18 16:33:40 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 18 16:33:41 volumiobatt ntpd[1028]: Soliciting pool server 151.0.2.53 Mar 18 16:33:42 volumiobatt ntpd[1028]: Soliciting pool server 5.178.87.15 Mar 18 16:33:42 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Mar 18 16:33:43 volumiobatt ntpd[1028]: Soliciting pool server 51.250.35.68 Mar 18 16:33:43 volumiobatt ntpd[1028]: Soliciting pool server 217.170.87.229 Mar 18 16:33:43 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 18 16:33:44 volumiobatt ntpd[1028]: Soliciting pool server 83.239.229.70 Mar 18 16:33:44 volumiobatt ntpd[1028]: Soliciting pool server 188.124.37.90 Mar 18 16:33:44 volumiobatt volumio[1234]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 18 16:33:44 volumiobatt volumio[1234]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 18 16:33:44 volumiobatt volumio[1234]: TypeError: Cannot read property 'replace' of undefined Mar 18 16:33:44 volumiobatt volumio[1234]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Mar 18 16:33:44 volumiobatt volumio[1234]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Mar 18 16:33:44 volumiobatt volumio[1234]: at listOnTimeout (internal/timers.js:554:17) Mar 18 16:33:44 volumiobatt volumio[1234]: at processTimers (internal/timers.js:497:7) Mar 18 16:33:44 volumiobatt volumio[1234]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 18 16:33:44 volumiobatt sudo[2358]: volumio : unable to resolve host volumiobatt Mar 18 16:33:44 volumiobatt sudo[2358]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Mar 18 16:33:44 volumiobatt sudo[2358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-18 16:32 Mar 18 16:33:44 volumiobatt sudo[2358]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"