-- Logs begin at Thu 2019-02-14 19:11:58 JST, end at Wed 2025-05-07 21:35:54 JST. -- May 07 21:35:28 volumio46 systemd-timedated[995]: Changed local time to Wed May 7 21:35:28 2025 May 07 21:35:28 volumio46 sudo[993]: pam_unix(sudo:session): session closed for user root May 07 21:35:28 volumio46 volumio-time-update[580]: volumio-time-update-util: System time updated successfully. May 07 21:35:28 volumio46 systemd[1]: Started Volumio Time Update Utility. May 07 21:35:28 volumio46 ntpd[737]: Listen normally on 3 wlan0 172.16.80.109:123 May 07 21:35:28 volumio46 ntpd[737]: new interface(s) found: waking up resolver May 07 21:35:28 volumio46 nmbd[706]: [2025/05/07 21:35:28.666022, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 07 21:35:28 volumio46 systemd[1]: Started Samba NMB Daemon. May 07 21:35:28 volumio46 volumio[975]: info: ------------------------------------------- May 07 21:35:28 volumio46 volumio[975]: info: ----- Volumio3 ---- May 07 21:35:28 volumio46 volumio[975]: info: ------------------------------------------- May 07 21:35:28 volumio46 volumio[975]: info: ----- System startup ---- May 07 21:35:28 volumio46 volumio[975]: info: ------------------------------------------- May 07 21:35:28 volumio46 nmbd[706]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 07 21:35:28 volumio46 systemd[1]: Starting Samba Winbind Daemon... May 07 21:35:28 volumio46 winbindd[1005]: [2025/05/07 21:35:28.917016, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 07 21:35:28 volumio46 winbindd[1005]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 07 21:35:29 volumio46 winbindd[1005]: [2025/05/07 21:35:29.033311, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 07 21:35:29 volumio46 winbindd[1005]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 07 21:35:29 volumio46 systemd[1]: Started Samba Winbind Daemon. May 07 21:35:29 volumio46 systemd[1]: Starting Samba SMB Daemon... May 07 21:35:29 volumio46 volumio-remote-updater[572]: [2025-05-07 21:35:29] [connect] Successful connection May 07 21:35:29 volumio46 smbd[1010]: [2025/05/07 21:35:29.668530, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 07 21:35:29 volumio46 smbd[1010]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 07 21:35:29 volumio46 systemd[1]: Started Samba SMB Daemon. May 07 21:35:29 volumio46 systemd[1]: Reached target Multi-User System. May 07 21:35:29 volumio46 systemd[1]: Reached target Graphical Interface. May 07 21:35:29 volumio46 systemd[1]: Starting Update UTMP about System Runlevel Changes... May 07 21:35:29 volumio46 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 07 21:35:29 volumio46 systemd[1]: Started Update UTMP about System Runlevel Changes. May 07 21:35:29 volumio46 systemd[1]: Startup finished in 44.612s (kernel) + 26.804s (userspace) = 1min 11.417s. May 07 21:35:29 volumio46 volumio[975]: info: MYVOLUMIO Environment detected May 07 21:35:29 volumio46 volumio[975]: info: Plugin folders cleanup May 07 21:35:29 volumio46 volumio[975]: info: Scanning into folder /volumio/app/plugins/ May 07 21:35:29 volumio46 volumio[975]: info: Scanning category audio_interface May 07 21:35:29 volumio46 volumio[975]: info: Scanning category miscellanea May 07 21:35:29 volumio46 volumio[975]: info: Scanning category music_service May 07 21:35:29 volumio46 volumio[975]: info: Scanning category plugins.json May 07 21:35:29 volumio46 volumio[975]: info: Scanning category system_controller May 07 21:35:29 volumio46 volumio[975]: info: Scanning category user_interface May 07 21:35:29 volumio46 volumio[975]: info: Scanning into folder /data/plugins/ May 07 21:35:29 volumio46 volumio[975]: info: Scanning category music_service May 07 21:35:29 volumio46 volumio[975]: info: Plugin folders cleanup completed May 07 21:35:29 volumio46 volumio[975]: info: ------------------------------------------- May 07 21:35:29 volumio46 volumio[975]: info: ----- Core plugins startup ---- May 07 21:35:29 volumio46 volumio[975]: info: ------------------------------------------- May 07 21:35:29 volumio46 volumio[975]: info: Loading plugins from folder /volumio/app/plugins/ May 07 21:35:29 volumio46 volumio[975]: info: Adding plugin upnp to MyMusic Plugins May 07 21:35:29 volumio46 volumio[975]: info: Adding plugin airplay_emulation to MyMusic Plugins May 07 21:35:29 volumio46 volumio[975]: info: Adding plugin upnp_browser to MyMusic Plugins May 07 21:35:29 volumio46 volumio[975]: info: Loading plugins from folder /data/plugins/ May 07 21:35:29 volumio46 volumio[975]: info: Loading plugin "system"... May 07 21:35:29 volumio46 volumio[975]: info: Loading plugin "appearance"... May 07 21:35:30 volumio46 volumio[975]: info: Loading plugin "network"... May 07 21:35:30 volumio46 volumio[975]: info: Refreshing Cached IP Addresses May 07 21:35:30 volumio46 sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 21:35:30 volumio46 sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:30 volumio46 sudo[1030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 21:35:30 volumio46 sudo[1030]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:30 volumio46 sudo[1028]: pam_unix(sudo:session): session closed for user root May 07 21:35:30 volumio46 sudo[1030]: pam_unix(sudo:session): session closed for user root May 07 21:35:30 volumio46 volumio[975]: info: Loading plugin "services"... May 07 21:35:30 volumio46 volumio[975]: info: Loading plugin "alsa_controller"... May 07 21:35:30 volumio46 sudo[1039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 07 21:35:30 volumio46 sudo[1039]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:30 volumio46 volumio[975]: warn: Unable to locate the audio output device Sony USB DAC Amplifier. Please configure a valid output device. May 07 21:35:30 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 07 21:35:30 volumio46 volumio[975]: info: Loading plugin "wizard"... May 07 21:35:30 volumio46 volumio[975]: info: Loading plugin "networkfs"... May 07 21:35:31 volumio46 volumio[975]: info: Starting Udev Watcher for removable devices May 07 21:35:31 volumio46 sudo[1054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Syun,password=Synology4649,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //172.16.80.74/NAS/iTunes/iTunes Media/Music /mnt/NAS/Morbidelli21 May 07 21:35:31 volumio46 sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:31 volumio46 volumio[975]: info: Ignoring mount for partition: boot May 07 21:35:31 volumio46 volumio[975]: info: Ignoring mount for partition: volumio May 07 21:35:31 volumio46 volumio[975]: info: Ignoring mount for partition: volumio_data May 07 21:35:31 volumio46 volumio[975]: info: Mounting Device SSD_1TB May 07 21:35:31 volumio46 sudo[1064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/SSD_1TB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 May 07 21:35:31 volumio46 sudo[1064]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:31 volumio46 kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! May 07 21:35:31 volumio46 sudo[1064]: pam_unix(sudo:session): session closed for user root May 07 21:35:31 volumio46 kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. May 07 21:35:31 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "volumio_command_line_client"... May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "upnp"... May 07 21:35:31 volumio46 volumio[975]: info: [1746621331179] Starting Upmpd Daemon May 07 21:35:31 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "my_music"... May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "mpd"... May 07 21:35:31 volumio46 kernel: Key type cifs.spnego registered May 07 21:35:31 volumio46 kernel: Key type cifs.idmap registered May 07 21:35:31 volumio46 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. May 07 21:35:31 volumio46 kernel: CIFS: Attempting to mount //172.16.80.74/NAS/iTunes/iTunes Media/Music May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "upnp_browser"... May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "alarm-clock"... May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "airplay_emulation"... May 07 21:35:31 volumio46 volumio[975]: info: Starting Shairport Sync May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "last_100"... May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "webradio"... May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "i2s_dacs"... May 07 21:35:31 volumio46 volumio[975]: info: I2S DAC not set, start Auto-detection May 07 21:35:31 volumio46 volumio[975]: info: Loading plugin "volumiodiscovery"... May 07 21:35:32 volumio46 volumio[975]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 07 21:35:32 volumio46 volumio[975]: *** WARNING *** Please fix your application to use the native API of Avahi! May 07 21:35:32 volumio46 volumio[975]: *** WARNING *** For more information see May 07 21:35:32 volumio46 node[975]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 07 21:35:32 volumio46 volumio[975]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 07 21:35:32 volumio46 volumio[975]: *** WARNING *** Please fix your application to use the native API of Avahi! May 07 21:35:32 volumio46 volumio[975]: *** WARNING *** For more information see May 07 21:35:32 volumio46 node[975]: *** WARNING *** Please fix your application to use the native API of Avahi! May 07 21:35:32 volumio46 node[975]: *** WARNING *** For more information see May 07 21:35:32 volumio46 node[975]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 07 21:35:32 volumio46 node[975]: *** WARNING *** Please fix your application to use the native API of Avahi! May 07 21:35:32 volumio46 node[975]: *** WARNING *** For more information see May 07 21:35:32 volumio46 volumio[975]: info: Applying required configuration parameters for plugin volumiodiscovery May 07 21:35:32 volumio46 volumio[975]: info: Discovery: Started advertising with name: Volumio46 May 07 21:35:32 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 07 21:35:32 volumio46 volumio[975]: info: Loading plugin "outputs"... May 07 21:35:32 volumio46 volumio[975]: info: Loading plugin "albumart"... May 07 21:35:32 volumio46 volumio[975]: info: Plugin example_plugin is not enabled May 07 21:35:32 volumio46 volumio[975]: info: Loading plugin "inputs"... May 07 21:35:32 volumio46 volumio[975]: info: Loading plugin "updater_comm"... May 07 21:35:32 volumio46 volumio[975]: info: Plugin mpdemulation is not enabled May 07 21:35:32 volumio46 volumio[975]: info: Loading plugin "rest_api"... May 07 21:35:32 volumio46 volumio[975]: info: Loading plugin "websocket"... May 07 21:35:32 volumio46 volumio[975]: Forking 3 albumart workers May 07 21:35:32 volumio46 volumio[975]: info: Starting Socket.io Server version 2.3.0 May 07 21:35:32 volumio46 volumio[975]: info: Loading plugin "jp_radio"... May 07 21:35:32 volumio46 volumio[975]: Starting albumart workers May 07 21:35:32 volumio46 volumio[975]: Starting albumart workers May 07 21:35:32 volumio46 volumio[975]: Starting albumart workers May 07 21:35:33 volumio46 volumio[975]: info: Loading i18n strings for locale en May 07 21:35:33 volumio46 volumio[975]: Updating browse sources language May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::initPlayerControls May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:33 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:35:34 volumio46 volumio[975]: Express server listening on port 3000 May 07 21:35:34 volumio46 volumio[975]: [Metrics] WebUI: 5s 866.80ms May 07 21:35:34 volumio46 volumio[975]: info: CoreStateMachine::resetVolumioState May 07 21:35:34 volumio46 volumio[975]: info: CoreStateMachine::getcurrentVolume May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::volumioRetrievevolume May 07 21:35:34 volumio46 volumio[975]: info: CoreStateMachine::pushState May 07 21:35:34 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::volumioPushState May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:35:34 volumio46 volumio[975]: info: Volumio Network Manager: Network status updated: 2 May 07 21:35:34 volumio46 volumio-remote-updater[572]: [2025-05-07 21:35:34] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1746621329 101 May 07 21:35:34 volumio46 volumio[975]: 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 07 21:35:34 volumio46 volumio[975]: verbose: New Socket.io Connection to 172.16.80.109:3000 from 172.16.80.4 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 07 21:35:34 volumio46 volumio[975]: info: Scanning new location : "USB/SSD_1TB" May 07 21:35:34 volumio46 volumio[975]: info: Reloading queue from file May 07 21:35:34 volumio46 volumio[975]: info: CoreStateMachine::setRepeat null single undefined May 07 21:35:34 volumio46 volumio[975]: info: CoreStateMachine::pushState May 07 21:35:34 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::volumioPushState May 07 21:35:34 volumio46 volumio[975]: info: CoreStateMachine::setRandom null May 07 21:35:34 volumio46 volumio[975]: info: CoreStateMachine::pushState May 07 21:35:34 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::volumioPushState May 07 21:35:34 volumio46 volumio[975]: info: Setting Device type: Raspberry PI May 07 21:35:34 volumio46 volumio[975]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 07 21:35:34 volumio46 volumio[975]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03112 May 07 21:35:34 volumio46 volumio[975]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 07 21:35:34 volumio46 volumio[975]: info: Discovery: adding 64958228-459a-4d0e-930d-e8aa9b918482 May 07 21:35:34 volumio46 volumio[975]: info: Discovery: Found device Volumio May 07 21:35:34 volumio46 volumio[975]: info: Discovery: Connecting to remote: 172.16.80.4 May 07 21:35:34 volumio46 volumio[975]: info: Discovery: adding 7fbd151a-7493-40ac-9bac-dbe35ba54fe0 May 07 21:35:34 volumio46 volumio[975]: info: Discovery: Found device Volumio46 May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetState May 07 21:35:34 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 07 21:35:34 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetState May 07 21:35:34 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:34 volumio46 volumio[975]: info: Discovery: Connected to remote: 172.16.80.4 May 07 21:35:34 volumio46 sudo[1039]: pam_unix(sudo:session): session closed for user root May 07 21:35:34 volumio46 sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 21:35:34 volumio46 sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:34 volumio46 sudo[1147]: pam_unix(sudo:session): session closed for user root May 07 21:35:34 volumio46 sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 21:35:34 volumio46 sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:34 volumio46 sudo[1149]: pam_unix(sudo:session): session closed for user root May 07 21:35:34 volumio46 volumio[975]: verbose: New Socket.io Connection to 172.16.80.109 from 172.16.80.45 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.4 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 3 May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetVisibleSources May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetState May 07 21:35:35 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 07 21:35:35 volumio46 volumio[975]: info: Received Get System Info May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:35:35 volumio46 volumio[975]: info: Discovery: Getting this device information May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetState May 07 21:35:35 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetState May 07 21:35:35 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:35 volumio46 volumio[975]: info: Listing playlists May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 07 21:35:35 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 07 21:35:35 volumio46 systemd[1]: systemd-fsckd.service: Succeeded. May 07 21:35:36 volumio46 sh[499]: timed out May 07 21:35:36 volumio46 dhcpcd[554]: timed out May 07 21:35:36 volumio46 sh[499]: dhcpcd exited May 07 21:35:36 volumio46 dhcpcd[554]: dhcpcd exited May 07 21:35:36 volumio46 sh[499]: ifup: failed to bring up eth0 May 07 21:35:36 volumio46 systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE May 07 21:35:36 volumio46 systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. May 07 21:35:36 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 07 21:35:36 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 21:35:36 volumio46 volumio[975]: info: Received Get System Info May 07 21:35:36 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:35:36 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:35:36 volumio46 volumio[975]: info: Discovery: Getting this device information May 07 21:35:36 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetState May 07 21:35:36 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:36 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:35:38 volumio46 systemd[1]: systemd-hostnamed.service: Succeeded. May 07 21:35:39 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 21:35:39 volumio46 volumio[975]: info: Received Get System Info May 07 21:35:39 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:35:39 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:35:39 volumio46 volumio[975]: info: Discovery: Getting this device information May 07 21:35:39 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetState May 07 21:35:39 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:39 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:35:40 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 07 21:35:41 volumio46 sudo[1171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 21:35:41 volumio46 sudo[1171]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:41 volumio46 sudo[1171]: pam_unix(sudo:session): session closed for user root May 07 21:35:41 volumio46 sudo[1173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 21:35:41 volumio46 sudo[1173]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:41 volumio46 sudo[1173]: pam_unix(sudo:session): session closed for user root May 07 21:35:41 volumio46 sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 07 21:35:41 volumio46 sudo[1177]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:41 volumio46 systemd[1]: Started UPnP Renderer front-end to MPD. May 07 21:35:41 volumio46 sudo[1177]: pam_unix(sudo:session): session closed for user root May 07 21:35:41 volumio46 volumio[975]: info: Upmpdcli Daemon Started May 07 21:35:41 volumio46 volumio[1179]: Generating RSA private key, 4096 bit long modulus (2 primes) May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetBrowseSources May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetBrowseSources May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetBrowseSources May 07 21:35:41 volumio46 kernel: cryptd: max_cpu_qlen set to 1000 May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 21:35:41 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 07 21:35:44 volumio46 volumio[1179]: ...................................++++ May 07 21:35:44 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 21:35:45 volumio46 volumio[1179]: ......++++ May 07 21:35:45 volumio46 volumio[1179]: e is 65537 (0x010001) May 07 21:35:45 volumio46 volumio[1179]: writing RSA key May 07 21:35:45 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 21:35:46 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 07 21:35:48 volumio46 sudo[1054]: pam_unix(sudo:session): session closed for user root May 07 21:35:48 volumio46 volumio[975]: info: Cannot mount NAS Morbidelli21 at system boot, trial number 1 ,retrying in 5 seconds May 07 21:35:48 volumio46 volumio[975]: info: Completed loading Core Plugins May 07 21:35:48 volumio46 volumio[975]: info: Preparing to generate the ALSA configuration file May 07 21:35:48 volumio46 volumio[975]: info: Asound.conf file unchanged, so no further update is needed May 07 21:35:48 volumio46 volumio[975]: info: Output device has changed, restarting MPD May 07 21:35:48 volumio46 volumio[975]: info: Output device has changed, restarting Shairport Sync May 07 21:35:48 volumio46 sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:35:48 volumio46 sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:48 volumio46 sudo[1236]: pam_unix(sudo:session): session closed for user root May 07 21:35:48 volumio46 sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 21:35:48 volumio46 sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:48 volumio46 systemd[1]: Stopping Music Player Daemon... May 07 21:35:48 volumio46 volumio[975]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 21:35:48 volumio46 volumio[975]: info: ___________ START PLUGINS ___________ May 07 21:35:48 volumio46 volumio[975]: info: ControllerMpd::onStart: Initializing MPD May 07 21:35:48 volumio46 volumio[975]: info: Creating MPD Configuration file May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:35:48 volumio46 sudo[1245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 07 21:35:48 volumio46 volumio[975]: info: [1746621348732] CoreMusicLibrary::Adding element Media Servers May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:35:48 volumio46 sudo[1245]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:48 volumio46 sudo[1245]: pam_unix(sudo:session): session closed for user root May 07 21:35:48 volumio46 sudo[1247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 21:35:48 volumio46 sudo[1247]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:35:48 volumio46 volumio[975]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:35:48 volumio46 volumio[975]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 07 21:35:48 volumio46 volumio[975]: info: [1746621348814] CoreMusicLibrary::Adding element Last_100 May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 07 21:35:48 volumio46 volumio[975]: info: [1746621348816] CoreMusicLibrary::Adding element Webradio May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 07 21:35:48 volumio46 volumio[975]: info: Initializing BBC Radios May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 07 21:35:48 volumio46 volumio[975]: info: [1746621348914] CoreMusicLibrary::Adding element RADIKO May 07 21:35:48 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:35:48 volumio46 volumio[975]: Cannot find translation for source RADIKO May 07 21:35:48 volumio46 volumio[975]: info: Volumio Calling Home May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 07 21:35:49 volumio46 volumio[975]: info: MPD Permissions set May 07 21:35:49 volumio46 volumio[975]: info: MPD Permissions set May 07 21:35:49 volumio46 volumio[975]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:35:49 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetState May 07 21:35:49 volumio46 volumio[975]: info: CorePlayQueue::getTrack 0 May 07 21:35:49 volumio46 volumio[975]: info: Starting Shairport Sync May 07 21:35:49 volumio46 volumio[975]: info: Starting Shairport Sync May 07 21:35:49 volumio46 volumio[975]: info: Starting Shairport Sync May 07 21:35:49 volumio46 sudo[1278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 21:35:49 volumio46 sudo[1278]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:49 volumio46 sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 21:35:49 volumio46 sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:49 volumio46 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 07 21:35:49 volumio46 systemd[1]: shairport-sync.service: Succeeded. May 07 21:35:49 volumio46 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 07 21:35:49 volumio46 sudo[1283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 21:35:49 volumio46 sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:35:49 volumio46 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 07 21:35:49 volumio46 sudo[1278]: pam_unix(sudo:session): session closed for user root May 07 21:35:49 volumio46 volumio[975]: info: Shairport-Sync Started May 07 21:35:49 volumio46 volumio[975]: Error adding Membership: Error: addMembership EINVAL May 07 21:35:49 volumio46 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 07 21:35:49 volumio46 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM May 07 21:35:49 volumio46 systemd[1]: shairport-sync.service: Succeeded. May 07 21:35:49 volumio46 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 07 21:35:49 volumio46 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 07 21:35:49 volumio46 sudo[1280]: pam_unix(sudo:session): session closed for user root May 07 21:35:49 volumio46 sudo[1283]: pam_unix(sudo:session): session closed for user root May 07 21:35:49 volumio46 volumio[975]: info: Shairport-Sync Started May 07 21:35:49 volumio46 volumio[975]: info: Shairport-Sync Started May 07 21:35:49 volumio46 volumio[975]: info: Volumio called home May 07 21:35:49 volumio46 volumio[975]: info: JP_Radio::getting stations May 07 21:35:50 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 21:35:52 volumio46 volumio[975]: info: CoreCommandRouter::volumioGetQueue May 07 21:35:52 volumio46 volumio[975]: info: CoreStateMachine::getQueue May 07 21:35:52 volumio46 volumio[975]: info: CorePlayQueue::getQueue May 07 21:35:52 volumio46 volumio[975]: info: JP_Radio::Updating program listings May 07 21:35:53 volumio46 volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 07 21:35:53 volumio46 volumio[975]: info: CURURI: music-library May 07 21:35:53 volumio46 volumio[975]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined May 07 21:35:53 volumio46 volumio[975]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 21:35:53 volumio46 volumio[975]: TypeError: Cannot read property 'replace' of undefined May 07 21:35:53 volumio46 volumio[975]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) May 07 21:35:53 volumio46 volumio[975]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) May 07 21:35:53 volumio46 volumio[975]: at listOnTimeout (internal/timers.js:554:17) May 07 21:35:53 volumio46 volumio[975]: at processTimers (internal/timers.js:497:7) May 07 21:35:53 volumio46 volumio[975]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 21:35:54 volumio46 sudo[1316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-07 21:34 May 07 21:35:54 volumio46 sudo[1316]: 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="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"