-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sun 2025-05-18 07:10:25 CST. -- May 18 07:09:08 volumio systemd-timedated[1005]: Changed local time to Sun May 18 07:09:08 2025 May 18 07:09:08 volumio sudo[995]: pam_unix(sudo:session): session closed for user root May 18 07:09:08 volumio volumio-time-update[652]: volumio-time-update-util: System time updated successfully. May 18 07:09:08 volumio systemd[1]: Started Volumio Time Update Utility. May 18 07:09:08 volumio systemd[1]: Reached target Multi-User System. May 18 07:09:08 volumio systemd[1]: Reached target Graphical Interface. May 18 07:09:08 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 18 07:09:08 volumio systemd[1]: Starting Daily apt download activities... May 18 07:09:08 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 18 07:09:08 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 18 07:09:08 volumio volumio[855]: info: Loading plugin "upnp_browser"... May 18 07:09:08 volumio volumio[855]: info: Loading plugin "alarm-clock"... May 18 07:09:08 volumio systemd[1]: apt-daily.service: Succeeded. May 18 07:09:08 volumio systemd[1]: Started Daily apt download activities. May 18 07:09:08 volumio volumio[855]: info: Loading plugin "airplay_emulation"... May 18 07:09:08 volumio systemd[1]: Starting Daily apt upgrade and clean activities... May 18 07:09:08 volumio volumio[855]: info: Starting Shairport Sync May 18 07:09:08 volumio volumio[855]: info: Loading plugin "last_100"... May 18 07:09:08 volumio volumio[855]: info: Loading plugin "webradio"... May 18 07:09:08 volumio volumio[855]: info: Loading plugin "i2s_dacs"... May 18 07:09:08 volumio volumio-remote-updater[650]: [2025-05-18 07:09:08] [connect] Successful connection May 18 07:09:08 volumio volumio[855]: info: I2S DAC not set, start Auto-detection May 18 07:09:08 volumio volumio[855]: info: Loading plugin "volumiodiscovery"... May 18 07:09:08 volumio volumio[855]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 18 07:09:08 volumio volumio[855]: *** WARNING *** Please fix your application to use the native API of Avahi! May 18 07:09:08 volumio volumio[855]: *** WARNING *** For more information see May 18 07:09:08 volumio node[855]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 18 07:09:08 volumio volumio[855]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 18 07:09:08 volumio volumio[855]: *** WARNING *** Please fix your application to use the native API of Avahi! May 18 07:09:08 volumio volumio[855]: *** WARNING *** For more information see May 18 07:09:08 volumio node[855]: *** WARNING *** Please fix your application to use the native API of Avahi! May 18 07:09:08 volumio node[855]: *** WARNING *** For more information see May 18 07:09:08 volumio node[855]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 18 07:09:08 volumio node[855]: *** WARNING *** Please fix your application to use the native API of Avahi! May 18 07:09:08 volumio node[855]: *** WARNING *** For more information see May 18 07:09:08 volumio volumio[855]: info: Applying required configuration parameters for plugin volumiodiscovery May 18 07:09:08 volumio volumio[855]: info: Discovery: Started advertising with name: Volumio May 18 07:09:08 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 18 07:09:08 volumio volumio[855]: info: Loading plugin "outputs"... May 18 07:09:08 volumio volumio[855]: info: Loading plugin "albumart"... May 18 07:09:09 volumio volumio[855]: info: Plugin example_plugin is not enabled May 18 07:09:09 volumio volumio[855]: info: Loading plugin "inputs"... May 18 07:09:09 volumio volumio[855]: info: Loading plugin "updater_comm"... May 18 07:09:09 volumio volumio[855]: info: Plugin mpdemulation is not enabled May 18 07:09:09 volumio volumio[855]: info: Loading plugin "rest_api"... May 18 07:09:09 volumio volumio[855]: info: Loading plugin "websocket"... May 18 07:09:09 volumio volumio[855]: info: Starting Socket.io Server version 2.3.0 May 18 07:09:09 volumio volumio[855]: Forking 3 albumart workers May 18 07:09:09 volumio volumio[855]: info: Loading i18n strings for locale zh May 18 07:09:09 volumio volumio[855]: Updating browse sources language May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 07:09:09 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. May 18 07:09:09 volumio systemd[1]: Started Daily apt upgrade and clean activities. May 18 07:09:09 volumio systemd[1]: Startup finished in 12.291s (kernel) + 23.279s (userspace) = 35.571s. May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::initPlayerControls May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:09:09 volumio volumio[855]: Express server listening on port 3000 May 18 07:09:09 volumio volumio[855]: [Metrics] WebUI: 4s 802.11ms May 18 07:09:09 volumio volumio[855]: info: CoreStateMachine::resetVolumioState May 18 07:09:09 volumio volumio[855]: info: CoreStateMachine::getcurrentVolume May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::volumioRetrievevolume May 18 07:09:09 volumio volumio[855]: info: CoreStateMachine::pushState May 18 07:09:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:09 volumio volumio[855]: info: Volumio Network Manager: Network status updated: 1 May 18 07:09:09 volumio volumio-remote-updater[650]: [2025-05-18 07:09:09] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747523348 101 May 18 07:09:09 volumio volumio[855]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 May 18 07:09:09 volumio volumio[855]: info: Reloading queue from file May 18 07:09:09 volumio volumio[855]: info: CoreStateMachine::setRepeat null single undefined May 18 07:09:09 volumio volumio[855]: info: CoreStateMachine::pushState May 18 07:09:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState May 18 07:09:09 volumio volumio[855]: info: CoreStateMachine::setRandom null May 18 07:09:09 volumio volumio[855]: info: CoreStateMachine::pushState May 18 07:09:09 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState May 18 07:09:09 volumio volumio[855]: info: Setting Device type: Raspberry PI May 18 07:09:09 volumio volumio[855]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 18 07:09:09 volumio volumio[855]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 May 18 07:09:09 volumio volumio[855]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 18 07:09:09 volumio volumio[855]: Starting albumart workers May 18 07:09:09 volumio volumio[855]: Starting albumart workers May 18 07:09:09 volumio volumio[855]: Starting albumart workers May 18 07:09:10 volumio volumio[855]: info: Discovery: adding afe59035-08cf-4bc0-98a6-1c45578f0e8b May 18 07:09:10 volumio volumio[855]: info: Discovery: Found device Volumio May 18 07:09:10 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:10 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:14 volumio sudo[974]: pam_unix(sudo:session): session closed for user root May 18 07:09:14 volumio volumio[855]: info: Cannot mount NAS H1 at system boot, trial number 1 ,retrying in 5 seconds May 18 07:09:14 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:09:14 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:09:14 volumio kernel: CIFS: Attempting to mount //10.247.1.142/Music May 18 07:09:17 volumio sudo[1185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 18 07:09:17 volumio sudo[1185]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:17 volumio sudo[1185]: pam_unix(sudo:session): session closed for user root May 18 07:09:17 volumio sudo[1187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 18 07:09:17 volumio sudo[1187]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:17 volumio sudo[1187]: pam_unix(sudo:session): session closed for user root May 18 07:09:17 volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 18 07:09:17 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:18 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 18 07:09:18 volumio sudo[1191]: pam_unix(sudo:session): session closed for user root May 18 07:09:18 volumio volumio[855]: info: Upmpdcli Daemon Started May 18 07:09:18 volumio volumio[1193]: Generating RSA private key, 4096 bit long modulus (2 primes) May 18 07:09:19 volumio sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=hjr3302,password=Hjr006470,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.247.1.142/music /mnt/NAS/H1 May 18 07:09:19 volumio sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:20 volumio sudo[971]: pam_unix(sudo:session): session closed for user root May 18 07:09:20 volumio volumio[855]: info: Cannot mount NAS Hifi at system boot, trial number 1 ,retrying in 5 seconds May 18 07:09:20 volumio volumio[855]: info: Completed loading Core Plugins May 18 07:09:20 volumio volumio[855]: info: Preparing to generate the ALSA configuration file May 18 07:09:20 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:09:20 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:09:20 volumio kernel: CIFS: Attempting to mount //10.247.1.142/music May 18 07:09:20 volumio volumio[855]: info: Asound.conf file unchanged, so no further update is needed May 18 07:09:20 volumio volumio[855]: info: Output device has changed, restarting MPD May 18 07:09:20 volumio sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 18 07:09:20 volumio volumio[855]: info: Output device has changed, restarting Shairport Sync May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:20 volumio sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:20 volumio sudo[1215]: pam_unix(sudo:session): session closed for user root May 18 07:09:20 volumio sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 18 07:09:20 volumio sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:20 volumio volumio[855]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 18 07:09:20 volumio volumio[855]: info: ___________ START PLUGINS ___________ May 18 07:09:20 volumio systemd[1]: Stopping Music Player Daemon... May 18 07:09:20 volumio volumio[855]: info: ControllerMpd::onStart: Initializing MPD May 18 07:09:20 volumio volumio[855]: info: Creating MPD Configuration file May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 07:09:20 volumio volumio[855]: info: [1747523360431] CoreMusicLibrary::Adding element 媒体服务器 May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 07:09:20 volumio sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 18 07:09:20 volumio sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:20 volumio sudo[1226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 18 07:09:20 volumio sudo[1226]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:20 volumio sudo[1224]: pam_unix(sudo:session): session closed for user root May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:20 volumio volumio[855]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:20 volumio systemd[1]: mpd.service: Succeeded. May 18 07:09:20 volumio systemd[1]: Stopped Music Player Daemon. May 18 07:09:20 volumio volumio[855]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 07:09:20 volumio volumio[855]: info: [1747523360533] CoreMusicLibrary::Adding element Last_100 May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 07:09:20 volumio volumio[855]: info: [1747523360535] CoreMusicLibrary::Adding element Webradio May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 07:09:20 volumio volumio[855]: info: Initializing BBC Radios May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:20 volumio volumio[855]: info: Volumio Calling Home May 18 07:09:20 volumio systemd[1]: Starting Music Player Daemon... May 18 07:09:20 volumio sudo[1235]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 18 07:09:20 volumio sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:20 volumio sudo[1235]: pam_unix(sudo:session): session closed for user root May 18 07:09:20 volumio volumio[855]: info: MPD Permissions set May 18 07:09:20 volumio volumio[855]: info: MPD Permissions set May 18 07:09:20 volumio volumio[855]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:20 volumio volumio[855]: info: Starting Shairport Sync May 18 07:09:20 volumio volumio[855]: info: Starting Shairport Sync May 18 07:09:20 volumio sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 18 07:09:20 volumio sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:20 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:20 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 18 07:09:20 volumio sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 18 07:09:20 volumio sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:20 volumio systemd[1]: shairport-sync.service: Succeeded. May 18 07:09:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 18 07:09:20 volumio volumio[855]: info: Starting Shairport Sync May 18 07:09:20 volumio sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 18 07:09:20 volumio sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 18 07:09:20 volumio sudo[1260]: pam_unix(sudo:session): session closed for user root May 18 07:09:20 volumio volumio[855]: info: Shairport-Sync Started May 18 07:09:20 volumio volumio[855]: Error adding Membership: Error: addMembership EINVAL May 18 07:09:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 18 07:09:20 volumio systemd[1]: shairport-sync.service: Succeeded. May 18 07:09:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 18 07:09:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 18 07:09:20 volumio sudo[1267]: pam_unix(sudo:session): session closed for user root May 18 07:09:20 volumio volumio[855]: info: Shairport-Sync Started May 18 07:09:20 volumio sudo[1262]: pam_unix(sudo:session): session closed for user root May 18 07:09:20 volumio volumio[855]: info: Shairport-Sync Started May 18 07:09:21 volumio mpd[1250]: May 18 07:09 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 18 07:09:21 volumio systemd[1]: Started Music Player Daemon. May 18 07:09:21 volumio sudo[1226]: pam_unix(sudo:session): session closed for user root May 18 07:09:21 volumio sudo[1217]: pam_unix(sudo:session): session closed for user root May 18 07:09:21 volumio volumio[855]: info: Completed starting Core Plugins May 18 07:09:21 volumio volumio[855]: info: ------------------------------------------- May 18 07:09:21 volumio volumio[855]: info: ----- MyVolumio plugins startup ---- May 18 07:09:21 volumio volumio[855]: info: ------------------------------------------- May 18 07:09:21 volumio volumio[855]: info: [MyVolumio PluginManager] Fetching plans data.... May 18 07:09:21 volumio volumio[855]: error: MPD error: The expression evaluated to a falsy value: May 18 07:09:21 volumio volumio[855]: assert.ok(self.idling) May 18 07:09:21 volumio volumio[855]: error: The expression evaluated to a falsy value: May 18 07:09:21 volumio volumio[855]: assert.ok(self.idling) May 18 07:09:21 volumio volumio[855]: info: MPD running with PID1250 May 18 07:09:21 volumio volumio[855]: ,establishing connection May 18 07:09:21 volumio volumio[855]: error: MPD error: The expression evaluated to a falsy value: May 18 07:09:21 volumio volumio[855]: assert.ok(self.idling) May 18 07:09:21 volumio volumio[855]: error: The expression evaluated to a falsy value: May 18 07:09:21 volumio volumio[855]: assert.ok(self.idling) May 18 07:09:21 volumio volumio[855]: error: updateQueue error: null May 18 07:09:21 volumio volumio[855]: info: Volumio called home May 18 07:09:24 volumio systemd[1]: systemd-fsckd.service: Succeeded. May 18 07:09:25 volumio sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=hjr3302,password=Hjr006470,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.247.1.142/Music /mnt/NAS/Hifi May 18 07:09:25 volumio sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:26 volumio sudo[1210]: pam_unix(sudo:session): session closed for user root May 18 07:09:26 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:09:26 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:09:26 volumio kernel: CIFS: Attempting to mount //10.247.1.142/Music May 18 07:09:26 volumio volumio[855]: info: Cannot mount NAS H1 at system boot, trial number 2 ,retrying in 5 seconds May 18 07:09:27 volumio volumio[1193]: ..................................................................................................++++ May 18 07:09:27 volumio volumio[1193]: .++++ May 18 07:09:27 volumio volumio[1193]: e is 65537 (0x010001) May 18 07:09:27 volumio volumio[1193]: writing RSA key May 18 07:09:29 volumio systemd[1]: systemd-hostnamed.service: Succeeded. May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 18 07:09:30 volumio volumio[855]: info: Adding plugin bluetooth to MyMusic Plugins May 18 07:09:30 volumio volumio[855]: info: Adding plugin multiroom to MyMusic Plugins May 18 07:09:30 volumio volumio[855]: info: Adding plugin metavolumio to MyMusic Plugins May 18 07:09:30 volumio volumio[855]: info: Adding plugin cd_controller to MyMusic Plugins May 18 07:09:30 volumio volumio[855]: info: Adding plugin qobuzconnect to MyMusic Plugins May 18 07:09:30 volumio volumio[855]: info: Adding plugin smart_inputs to MyMusic Plugins May 18 07:09:30 volumio volumio[855]: info: Adding plugin tidalconnect to MyMusic Plugins May 18 07:09:30 volumio volumio[855]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 18 07:09:31 volumio volumio[855]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 18 07:09:31 volumio volumio[855]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 18 07:09:31 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:31 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:31 volumio volumio[855]: info: Starting MyVolumio Remote Streaming Endpoints May 18 07:09:31 volumio volumio[855]: info: MyVolumio not started May 18 07:09:31 volumio volumio[855]: info: Initializing device activation check May 18 07:09:31 volumio volumio[855]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 18 07:09:31 volumio volumio[855]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 18 07:09:32 volumio volumio[855]: info: Starting Streaming Service Transparent Proxy May 18 07:09:32 volumio volumio[855]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 18 07:09:32 volumio volumio[855]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 18 07:09:32 volumio volumio[855]: info: Streaming services startup May 18 07:09:32 volumio volumio[855]: info: Starting Streaming Daemon May 18 07:09:32 volumio sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 18 07:09:32 volumio sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:32 volumio sudo[1328]: pam_unix(sudo:session): session closed for user root May 18 07:09:32 volumio volumio[855]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 18 07:09:32 volumio sudo[1336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=hjr3302,password=Hjr006470,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.247.1.142/music /mnt/NAS/H1 May 18 07:09:32 volumio sudo[1336]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:32 volumio volumio[855]: error: Cannot start Volumio Streaming Daemon May 18 07:09:32 volumio volumio[855]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 18 07:09:32 volumio volumio[855]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 18 07:09:32 volumio sudo[1282]: pam_unix(sudo:session): session closed for user root May 18 07:09:32 volumio volumio[855]: info: Cannot mount NAS Hifi at system boot, trial number 2 ,retrying in 5 seconds May 18 07:09:32 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:09:32 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:09:32 volumio kernel: CIFS: Attempting to mount //10.247.1.142/music May 18 07:09:32 volumio volumio[855]: STREAMING PROXY: Starting server on port 3245 May 18 07:09:32 volumio volumio[855]: Node JS runtime: 14 May 18 07:09:37 volumio sudo[1355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=hjr3302,password=Hjr006470,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.247.1.142/Music /mnt/NAS/Hifi May 18 07:09:37 volumio sudo[1355]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:38 volumio systemd[1]: systemd-timedated.service: Succeeded. May 18 07:09:39 volumio sudo[1336]: pam_unix(sudo:session): session closed for user root May 18 07:09:39 volumio volumio[855]: info: Cannot mount NAS H1 at system boot, trial number 3 ,retrying in 5 seconds May 18 07:09:39 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:09:39 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:09:39 volumio kernel: CIFS: Attempting to mount //10.247.1.142/Music May 18 07:09:44 volumio sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=hjr3302,password=Hjr006470,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.247.1.142/music /mnt/NAS/H1 May 18 07:09:44 volumio sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:45 volumio sudo[1355]: pam_unix(sudo:session): session closed for user root May 18 07:09:45 volumio volumio[855]: info: Cannot mount NAS Hifi at system boot, trial number 3 ,retrying in 5 seconds May 18 07:09:45 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:09:45 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:09:45 volumio kernel: CIFS: Attempting to mount //10.247.1.142/music May 18 07:09:46 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 18 07:09:46 volumio volumio[855]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 May 18 07:09:46 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:46 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:50 volumio sudo[1384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=hjr3302,password=Hjr006470,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.247.1.142/Music /mnt/NAS/Hifi May 18 07:09:50 volumio sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 07:09:50 volumio volumio[855]: info: Discovery: Getting this device information May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:50 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 07:09:50 volumio volumio[855]: verbose: New Socket.io Connection to 10.247.1.177:3000 from 10.247.1.169 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:50 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 18 07:09:50 volumio volumio-remote-updater[650]: No test mode May 18 07:09:50 volumio volumio-remote-updater[650]: No alpha test mode May 18 07:09:50 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 18 07:09:51 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:51 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:51 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 18 07:09:51 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 18 07:09:51 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 18 07:09:51 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources May 18 07:09:51 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 07:09:51 volumio sudo[1362]: pam_unix(sudo:session): session closed for user root May 18 07:09:51 volumio volumio[855]: info: Cannot mount NAS H1 at system boot, trial number 4 ,retrying in 5 seconds May 18 07:09:51 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:09:51 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:09:51 volumio kernel: CIFS: Attempting to mount //10.247.1.142/Music May 18 07:09:51 volumio volumio[855]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n
    \n
  • Various Fixes for QOBUZ Connect
    • \n
\n

NEW ADDITIONS

\n
    \n
  • Qobuz Connect Ready
    • \n
\n","title":"Update v3.812","updateavailable":true} May 18 07:09:51 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 18 07:09:52 volumio volumio[855]: error: MyVolumio Plugin failed to authenticate in a timely fashion May 18 07:09:52 volumio volumio[855]: info: Completed starting MyVolumio Plugin May 18 07:09:52 volumio volumio[855]: [Metrics] CommandRouter: 46s 998.31ms May 18 07:09:52 volumio volumio[855]: info: CoreCommandRouter::volumiosetStartupVolume May 18 07:09:52 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 07:09:52 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 07:09:52 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent May 18 07:09:52 volumio volumio[855]: info: CoreCommandRouter::Close All Modals sent May 18 07:09:53 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 18 07:09:53 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 18 07:09:53 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 18 07:09:54 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 07:09:54 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 07:09:54 volumio volumio[855]: info: Discovery: Getting this device information May 18 07:09:54 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:54 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:54 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 07:09:55 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:55 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:56 volumio sudo[1434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 18 07:09:56 volumio sudo[1434]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:56 volumio sudo[1434]: pam_unix(sudo:session): session closed for user root May 18 07:09:56 volumio sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 18 07:09:56 volumio sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:56 volumio sudo[1436]: pam_unix(sudo:session): session closed for user root May 18 07:09:56 volumio volumio[855]: verbose: New Socket.io Connection to 10.247.1.177 from 10.247.1.169 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 18 07:09:56 volumio sudo[1440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 18 07:09:56 volumio sudo[1440]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:56 volumio sudo[1440]: pam_unix(sudo:session): session closed for user root May 18 07:09:56 volumio sudo[1442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 18 07:09:56 volumio sudo[1442]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:56 volumio sudo[1442]: pam_unix(sudo:session): session closed for user root May 18 07:09:56 volumio volumio[855]: verbose: New Socket.io Connection to 10.247.1.177 from 10.247.1.169 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 May 18 07:09:56 volumio sudo[1446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=hjr3302,password=Hjr006470,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.247.1.142/music /mnt/NAS/H1 May 18 07:09:56 volumio sudo[1446]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::volumioGetVisibleSources May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:56 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 18 07:09:56 volumio volumio[855]: info: Received Get System Info May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 07:09:56 volumio volumio[855]: info: Discovery: Getting this device information May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:56 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:56 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:56 volumio volumio[855]: info: Listing playlists May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 18 07:09:56 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 18 07:09:57 volumio sudo[1384]: pam_unix(sudo:session): session closed for user root May 18 07:09:57 volumio volumio[855]: info: Cannot mount NAS Hifi at system boot, trial number 4 ,retrying in 5 seconds May 18 07:09:57 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:09:57 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:09:57 volumio kernel: CIFS: Attempting to mount //10.247.1.142/music May 18 07:09:58 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 18 07:09:58 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 18 07:09:58 volumio volumio[855]: info: Received Get System Info May 18 07:09:58 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 07:09:58 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 07:09:58 volumio volumio[855]: info: Discovery: Getting this device information May 18 07:09:58 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:09:58 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:09:58 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 07:09:59 volumio volumio[855]: info: BOOT COMPLETED May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:09:59 volumio volumio[855]: info: Retrieving Cloud Streaming UI May 18 07:09:59 volumio volumio[855]: info: Getting Tidal Cloud Configuration May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:09:59 volumio volumio[855]: info: Getting Qobuz Cloud Configuration May 18 07:09:59 volumio volumio[855]: info: Asking plugin for UI Config May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:09:59 volumio volumio[855]: info: Getting Spotify Cloud Configuration May 18 07:09:59 volumio volumio[855]: info: Asking plugin for UI Config May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:09:59 volumio volumio[855]: info: Saving Spotify Acccount May 18 07:09:59 volumio volumio[855]: info: Got Tidal Cloud Configuration May 18 07:09:59 volumio volumio[855]: info: Got it May 18 07:09:59 volumio volumio[855]: info: Got it May 18 07:09:59 volumio volumio[855]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:09:59 volumio volumio[855]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 07:09:59 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 18 07:10:02 volumio sudo[1471]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=hjr3302,password=Hjr006470,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.247.1.142/Music /mnt/NAS/Hifi May 18 07:10:02 volumio sudo[1471]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 07:10:03 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 07:10:04 volumio sudo[1446]: pam_unix(sudo:session): session closed for user root May 18 07:10:04 volumio volumio[855]: info: Cannot mount NAS at system boot, trial number 4 ,stopping May 18 07:10:04 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:10:04 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:10:04 volumio kernel: CIFS: Attempting to mount //10.247.1.142/Music May 18 07:10:05 volumio ntpd[808]: Soliciting pool server 81.168.83.93 May 18 07:10:06 volumio ntpd[808]: Soliciting pool server 119.28.206.193 May 18 07:10:06 volumio ntpd[808]: Soliciting pool server 111.230.189.174 May 18 07:10:06 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 18 07:10:07 volumio ntpd[808]: Soliciting pool server 139.199.214.202 May 18 07:10:07 volumio ntpd[808]: Soliciting pool server 162.159.200.1 May 18 07:10:07 volumio ntpd[808]: Soliciting pool server 193.182.111.141 May 18 07:10:08 volumio ntpd[808]: Soliciting pool server 185.209.85.222 May 18 07:10:08 volumio ntpd[808]: Soliciting pool server 202.118.1.81 May 18 07:10:09 volumio ntpd[808]: Soliciting pool server 162.159.200.123 May 18 07:10:09 volumio ntpd[808]: Soliciting pool server 193.182.111.12 May 18 07:10:09 volumio ntpd[808]: Soliciting pool server 47.115.137.18 May 18 07:10:10 volumio sudo[1471]: pam_unix(sudo:session): session closed for user root May 18 07:10:10 volumio volumio[855]: info: Cannot mount NAS at system boot, trial number 4 ,stopping May 18 07:10:10 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. May 18 07:10:10 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:10:12 volumio volumio[855]: info: Retrieving Cloud Streaming UI May 18 07:10:12 volumio volumio[855]: info: Getting Tidal Cloud Configuration May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:10:12 volumio volumio[855]: info: Getting Qobuz Cloud Configuration May 18 07:10:12 volumio volumio[855]: info: Asking plugin for UI Config May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:10:12 volumio volumio[855]: info: Getting Spotify Cloud Configuration May 18 07:10:12 volumio volumio[855]: info: Asking plugin for UI Config May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:10:12 volumio volumio[855]: info: Saving Spotify Acccount May 18 07:10:12 volumio volumio[855]: info: Got Tidal Cloud Configuration May 18 07:10:12 volumio volumio[855]: info: Got it May 18 07:10:12 volumio volumio[855]: info: Got it May 18 07:10:12 volumio volumio[855]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 07:10:12 volumio volumio[855]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::volumioGetBrowseSources May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 07:10:12 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 18 07:10:14 volumio ntpd[808]: receive: Unexpected origin timestamp 0xebd395d6.20da023b does not match aorg 0000000000.00000000 from server@202.118.1.81 xmt 0xebd395d6.bf510314 May 18 07:10:14 volumio ntpd[808]: receive: Unexpected origin timestamp 0xebd395d6.20d7ef07 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xebd395d6.d0664d54 May 18 07:10:14 volumio ntpd[808]: receive: Unexpected origin timestamp 0xebd395d6.20dadc0b does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xebd395d6.d11c4880 May 18 07:10:14 volumio ntpd[808]: receive: Unexpected origin timestamp 0xebd395d6.20dd6ff6 does not match aorg 0000000000.00000000 from server@81.168.83.93 xmt 0xebd395d6.e4bc3708 May 18 07:10:15 volumio ntpd[808]: receive: Unexpected origin timestamp 0xebd395d6.20d5db70 does not match aorg 0000000000.00000000 from server@193.182.111.12 xmt 0xebd395d6.d89af8a9 May 18 07:10:17 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 07:10:19 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 07:10:19 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 07:10:19 volumio volumio[855]: info: Discovery: Getting this device information May 18 07:10:19 volumio volumio[855]: info: CoreCommandRouter::volumioGetState May 18 07:10:19 volumio volumio[855]: info: CorePlayQueue::getTrack 0 May 18 07:10:19 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 07:10:21 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 07:10:24 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue May 18 07:10:24 volumio volumio[855]: info: CoreStateMachine::getQueue May 18 07:10:24 volumio volumio[855]: info: CorePlayQueue::getQueue May 18 07:10:25 volumio volumio[855]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 07:10:25 volumio volumio[855]: Error: connect ECONNREFUSED 199.59.148.7:443 May 18 07:10:25 volumio volumio[855]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 18 07:10:25 volumio volumio[855]: errno: -111, May 18 07:10:25 volumio volumio[855]: code: 'ECONNREFUSED', May 18 07:10:25 volumio volumio[855]: syscall: 'connect', May 18 07:10:25 volumio volumio[855]: address: '199.59.148.7', May 18 07:10:25 volumio volumio[855]: port: 443 May 18 07:10:25 volumio volumio[855]: } May 18 07:10:25 volumio volumio[855]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 07:10:25 volumio sudo[1524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-18 07:09 May 18 07:10:25 volumio sudo[1524]: 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="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"